builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-002 starttime: 1451605526.87 results: success (0) buildid: 20151231133003 builduid: 11c0e2c9ee3f4ea89c1fc3f99577fc7e revision: 917f28fafccf95dc451ea390d0132814bf0081f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:26.871758) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:26.872152) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:26.872446) ========= bash -c pwd in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006400 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:26.937052) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:26.937321) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:26.978415) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:26.978704) ========= rm -rf properties in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004632 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:27.028870) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:27.029198) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:27.029572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:27.029857) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-31 15:45:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 84.1M=0s 2015-12-31 15:45:28 (84.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.462992 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:27.509202) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:27.509703) ========= rm -rf scripts in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:27.560107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:27.560447) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 917f28fafccf95dc451ea390d0132814bf0081f4 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 917f28fafccf95dc451ea390d0132814bf0081f4 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-31 15:45:28,170 truncating revision to first 12 chars 2015-12-31 15:45:28,170 Setting DEBUG logging. 2015-12-31 15:45:28,170 attempt 1/10 2015-12-31 15:45:28,171 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/917f28fafccf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-31 15:45:28,428 unpacking tar archive at: mozilla-inbound-917f28fafccf/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542099 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:28.114997) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:28.115330) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:28.123025) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:28.123320) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-31 15:45:28.123704) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-31 15:45:28.123978) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:45:28 INFO - MultiFileLogger online at 20151231 15:45:28 in /builds/slave/test-pgo 15:45:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 15:45:28 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 15:45:28 INFO - {'append_to_log': False, 15:45:28 INFO - 'base_work_dir': '/builds/slave/test-pgo', 15:45:28 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 15:45:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 15:45:28 INFO - 'branch': 'Mozilla-Inbound', 15:45:28 INFO - 'buildbot_json_path': 'buildprops.json', 15:45:28 INFO - 'config_files': ('talos/linux_config.py',), 15:45:28 INFO - 'default_actions': ('clobber', 15:45:28 INFO - 'read-buildbot-config', 15:45:28 INFO - 'download-and-extract', 15:45:28 INFO - 'populate-webroot', 15:45:28 INFO - 'create-virtualenv', 15:45:28 INFO - 'install', 15:45:28 INFO - 'run-tests'), 15:45:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:45:28 INFO - 'download_minidump_stackwalk': True, 15:45:28 INFO - 'download_symbols': 'ondemand', 15:45:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:45:28 INFO - 'tooltool.py': '/tools/tooltool.py', 15:45:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:45:28 INFO - '/tools/misc-python/virtualenv.py')}, 15:45:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:45:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:45:28 INFO - 'installer_path': 'installer.exe', 15:45:28 INFO - 'log_level': 'info', 15:45:28 INFO - 'log_name': 'talos', 15:45:28 INFO - 'log_to_console': True, 15:45:28 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:45:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:45:28 INFO - 'opt_config_files': (), 15:45:28 INFO - 'pip_index': False, 15:45:28 INFO - 'sps_profile': False, 15:45:28 INFO - 'sps_profile_interval': 0, 15:45:28 INFO - 'suite': 'dromaeojs-e10s', 15:45:28 INFO - 'system_bits': '32', 15:45:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:45:28 INFO - 'title': 'talos-linux64-ix-002', 15:45:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:45:28 INFO - 'use_talos_json': True, 15:45:28 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 15:45:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:45:28 INFO - 'work_dir': 'build'} 15:45:28 INFO - ##### 15:45:28 INFO - ##### Running clobber step. 15:45:28 INFO - ##### 15:45:28 INFO - Running pre-action listener: _resource_record_pre_action 15:45:28 INFO - Running main action method: clobber 15:45:28 INFO - rmtree: /builds/slave/test-pgo/build 15:45:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 15:45:29 INFO - Running post-action listener: _resource_record_post_action 15:45:29 INFO - ##### 15:45:29 INFO - ##### Running read-buildbot-config step. 15:45:29 INFO - ##### 15:45:29 INFO - Running pre-action listener: _resource_record_pre_action 15:45:29 INFO - Running main action method: read_buildbot_config 15:45:29 INFO - Using buildbot properties: 15:45:29 INFO - { 15:45:29 INFO - "project": "", 15:45:29 INFO - "product": "firefox", 15:45:29 INFO - "script_repo_revision": "production", 15:45:29 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs-e10s", 15:45:29 INFO - "repository": "", 15:45:29 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs-e10s", 15:45:29 INFO - "buildid": "20151231133003", 15:45:29 INFO - "pgo_build": "True", 15:45:29 INFO - "basedir": "/builds/slave/test-pgo", 15:45:29 INFO - "buildnumber": 576, 15:45:29 INFO - "slavename": "talos-linux64-ix-002", 15:45:29 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:45:29 INFO - "platform": "ubuntu64_hw", 15:45:29 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 15:45:29 INFO - "branch": "mozilla-inbound", 15:45:29 INFO - "repo_path": "integration/mozilla-inbound", 15:45:29 INFO - "revision": "917f28fafccf95dc451ea390d0132814bf0081f4", 15:45:29 INFO - "stage_platform": "linux64-pgo", 15:45:29 INFO - "builduid": "11c0e2c9ee3f4ea89c1fc3f99577fc7e", 15:45:29 INFO - "slavebuilddir": "test" 15:45:29 INFO - } 15:45:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 15:45:29 INFO - Running post-action listener: _resource_record_post_action 15:45:29 INFO - ##### 15:45:29 INFO - ##### Running download-and-extract step. 15:45:29 INFO - ##### 15:45:29 INFO - Running pre-action listener: _resource_record_pre_action 15:45:29 INFO - Running main action method: download_and_extract 15:45:29 INFO - mkdir: /builds/slave/test-pgo/build/tests 15:45:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:29 INFO - https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:45:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/test_packages.json 15:45:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/test_packages.json 15:45:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 15:45:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 15:45:33 INFO - Downloaded 1302 bytes. 15:45:33 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 15:45:33 INFO - Using the following test package requirements: 15:45:33 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:45:33 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:45:33 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:33 INFO - u'jsshell-linux-x86_64.zip'], 15:45:33 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:45:33 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:45:33 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:45:33 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:45:33 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:45:33 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 15:45:33 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 15:45:33 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:45:33 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:45:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:33 INFO - https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:45:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:45:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:45:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:45:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:45:38 INFO - Downloaded 23919884 bytes. 15:45:38 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:45:38 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:45:38 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:45:39 INFO - Return code: 0 15:45:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:45:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:39 INFO - https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:45:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:45:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:45:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:45:44 INFO - Downloaded 23919884 bytes. 15:45:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 15:45:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 15:45:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 15:45:45 INFO - Return code: 0 15:45:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:45 INFO - https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:45:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:45:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:45:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:45:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:45:47 INFO - Downloaded 11132285 bytes. 15:45:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 15:45:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 15:45:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 15:45:47 INFO - Return code: 0 15:45:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:47 INFO - https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:45:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:45:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:45:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:45:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:45:49 INFO - Downloaded 54965589 bytes. 15:45:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:45:49 INFO - mkdir: /builds/slave/test-pgo/properties 15:45:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 15:45:49 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 15:45:49 INFO - Contents: 15:45:49 INFO - build_url:https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 15:45:49 INFO - Running post-action listener: _resource_record_post_action 15:45:49 INFO - Running post-action listener: set_extra_try_arguments 15:45:49 INFO - ##### 15:45:49 INFO - ##### Running populate-webroot step. 15:45:49 INFO - ##### 15:45:49 INFO - Running pre-action listener: _resource_record_pre_action 15:45:49 INFO - Running main action method: populate_webroot 15:45:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:45:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:45:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:45:49 INFO - '--tppagecycles', 15:45:49 INFO - '7'], 15:45:49 INFO - 'tests': ['tsvgm']}}, 15:45:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:45:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:45:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:45:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:45:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:45:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:45:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:49 INFO - 'talos_options': ['--e10s'], 15:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:45:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:49 INFO - 'tests': ['damp', 'tps']}, 15:45:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:49 INFO - 'talos_options': ['--e10s'], 15:45:49 INFO - 'tests': ['damp', 'tps']}, 15:45:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:45:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:45:49 INFO - 'other': {'tests': ['a11yr', 15:45:49 INFO - 'ts_paint', 15:45:49 INFO - 'tpaint', 15:45:49 INFO - 'sessionrestore', 15:45:49 INFO - 'sessionrestore_no_auto_restore']}, 15:45:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:45:49 INFO - 'tests': ['a11yr', 15:45:49 INFO - 'ts_paint', 15:45:49 INFO - 'tpaint', 15:45:49 INFO - 'sessionrestore', 15:45:49 INFO - 'sessionrestore_no_auto_restore']}, 15:45:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:45:49 INFO - 'tests': ['a11yr', 15:45:49 INFO - 'ts_paint', 15:45:49 INFO - 'tpaint', 15:45:49 INFO - 'sessionrestore', 15:45:49 INFO - 'sessionrestore_no_auto_restore']}, 15:45:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:45:49 INFO - 'tests': ['a11yr', 15:45:49 INFO - 'ts_paint', 15:45:49 INFO - 'tpaint', 15:45:49 INFO - 'sessionrestore', 15:45:49 INFO - 'sessionrestore_no_auto_restore']}, 15:45:49 INFO - 'other_l64': {'tests': ['a11yr', 15:45:49 INFO - 'ts_paint', 15:45:49 INFO - 'tpaint', 15:45:49 INFO - 'sessionrestore', 15:45:49 INFO - 'sessionrestore_no_auto_restore']}, 15:45:49 INFO - 'other_nol64': {'tests': ['a11yr', 15:45:49 INFO - 'ts_paint', 15:45:49 INFO - 'tpaint', 15:45:49 INFO - 'sessionrestore', 15:45:49 INFO - 'sessionrestore_no_auto_restore']}, 15:45:49 INFO - 'svgr': {'tests': ['tsvgx', 15:45:49 INFO - 'tsvgr_opacity', 15:45:49 INFO - 'tart', 15:45:49 INFO - 'tscrollx', 15:45:49 INFO - 'cart']}, 15:45:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:45:49 INFO - 'tests': ['tsvgx', 15:45:49 INFO - 'tsvgr_opacity', 15:45:49 INFO - 'tart', 15:45:49 INFO - 'tscrollx', 15:45:49 INFO - 'cart']}, 15:45:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:49 INFO - 'tests': ['tp5o']}, 15:45:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:49 INFO - 'talos_options': ['--e10s'], 15:45:49 INFO - 'tests': ['tp5o']}, 15:45:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:49 INFO - 'talos_options': ['--xperf_path', 15:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:49 INFO - 'tests': ['tp5n']}, 15:45:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:45:49 INFO - 'talos_options': ['--e10s', 15:45:49 INFO - '--xperf_path', 15:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:45:49 INFO - 'tests': ['tp5n']}}, 15:45:49 INFO - 'talos.zip': {'path': '', 15:45:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:45:49 INFO - Running post-action listener: _resource_record_post_action 15:45:49 INFO - ##### 15:45:49 INFO - ##### Running create-virtualenv step. 15:45:49 INFO - ##### 15:45:49 INFO - Running pre-action listener: _resource_record_pre_action 15:45:49 INFO - Running main action method: create_virtualenv 15:45:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 15:45:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 15:45:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 15:45:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:45:49 INFO - Using real prefix '/usr' 15:45:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 15:45:49 INFO - Installing distribute.............................................................................................................................................................................................done. 15:45:51 INFO - Installing pip.................done. 15:45:51 INFO - Return code: 0 15:45:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 15:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:51 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f063f469f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:51 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 15:45:51 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:45:51 INFO - Using env: {'DISPLAY': ':0', 15:45:51 INFO - 'HOME': '/home/cltbld', 15:45:51 INFO - 'LANG': 'en_US.UTF-8', 15:45:51 INFO - 'LANGUAGE': 'en_US:en', 15:45:51 INFO - 'LOGNAME': 'cltbld', 15:45:51 INFO - 'MAIL': '/var/mail/cltbld', 15:45:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:51 INFO - 'MOZ_NO_REMOTE': '1', 15:45:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:51 INFO - 'NO_EM_RESTART': '1', 15:45:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:51 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:51 INFO - 'SHELL': '/bin/bash', 15:45:51 INFO - 'SHLVL': '1', 15:45:51 INFO - 'TERM': 'linux', 15:45:51 INFO - 'TMOUT': '86400', 15:45:51 INFO - 'USER': 'cltbld', 15:45:51 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:45:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:51 INFO - '_': '/tools/buildbot/bin/python'} 15:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:45:52 INFO - Cleaning up... 15:45:52 INFO - Return code: 0 15:45:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 15:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f063f469f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 15:45:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 15:45:52 INFO - Using env: {'DISPLAY': ':0', 15:45:52 INFO - 'HOME': '/home/cltbld', 15:45:52 INFO - 'LANG': 'en_US.UTF-8', 15:45:52 INFO - 'LANGUAGE': 'en_US:en', 15:45:52 INFO - 'LOGNAME': 'cltbld', 15:45:52 INFO - 'MAIL': '/var/mail/cltbld', 15:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:52 INFO - 'MOZ_NO_REMOTE': '1', 15:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:52 INFO - 'NO_EM_RESTART': '1', 15:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:52 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:52 INFO - 'SHELL': '/bin/bash', 15:45:52 INFO - 'SHLVL': '1', 15:45:52 INFO - 'TERM': 'linux', 15:45:52 INFO - 'TMOUT': '86400', 15:45:52 INFO - 'USER': 'cltbld', 15:45:52 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:52 INFO - '_': '/tools/buildbot/bin/python'} 15:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:52 INFO - Downloading/unpacking psutil>=0.7.1 15:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:53 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 15:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:45:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 15:45:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:54 INFO - Installing collected packages: psutil 15:45:54 INFO - Running setup.py install for psutil 15:45:54 INFO - building 'psutil._psutil_linux' extension 15:45:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 15:45:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 15:45:54 INFO - building 'psutil._psutil_posix' extension 15:45:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 15:45:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 15:45:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:45:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:45:54 INFO - Successfully installed psutil 15:45:54 INFO - Cleaning up... 15:45:54 INFO - Return code: 0 15:45:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 15:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:54 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f063f469f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:54 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 15:45:54 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 15:45:54 INFO - Using env: {'DISPLAY': ':0', 15:45:54 INFO - 'HOME': '/home/cltbld', 15:45:54 INFO - 'LANG': 'en_US.UTF-8', 15:45:54 INFO - 'LANGUAGE': 'en_US:en', 15:45:54 INFO - 'LOGNAME': 'cltbld', 15:45:54 INFO - 'MAIL': '/var/mail/cltbld', 15:45:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:54 INFO - 'MOZ_NO_REMOTE': '1', 15:45:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:54 INFO - 'NO_EM_RESTART': '1', 15:45:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:54 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:54 INFO - 'SHELL': '/bin/bash', 15:45:54 INFO - 'SHLVL': '1', 15:45:54 INFO - 'TERM': 'linux', 15:45:54 INFO - 'TMOUT': '86400', 15:45:54 INFO - 'USER': 'cltbld', 15:45:54 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:45:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:54 INFO - '_': '/tools/buildbot/bin/python'} 15:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:45:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:45:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:45:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:45:56 INFO - Installing collected packages: mozsystemmonitor 15:45:56 INFO - Running setup.py install for mozsystemmonitor 15:45:56 INFO - Successfully installed mozsystemmonitor 15:45:56 INFO - Cleaning up... 15:45:56 INFO - Return code: 0 15:45:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 15:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:56 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f063f469f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 15:45:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:45:56 INFO - Using env: {'DISPLAY': ':0', 15:45:56 INFO - 'HOME': '/home/cltbld', 15:45:56 INFO - 'LANG': 'en_US.UTF-8', 15:45:56 INFO - 'LANGUAGE': 'en_US:en', 15:45:56 INFO - 'LOGNAME': 'cltbld', 15:45:56 INFO - 'MAIL': '/var/mail/cltbld', 15:45:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:56 INFO - 'MOZ_NO_REMOTE': '1', 15:45:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:56 INFO - 'NO_EM_RESTART': '1', 15:45:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:56 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:56 INFO - 'SHELL': '/bin/bash', 15:45:56 INFO - 'SHLVL': '1', 15:45:56 INFO - 'TERM': 'linux', 15:45:56 INFO - 'TMOUT': '86400', 15:45:56 INFO - 'USER': 'cltbld', 15:45:56 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:45:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:56 INFO - '_': '/tools/buildbot/bin/python'} 15:45:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:45:56 INFO - Downloading/unpacking blobuploader==1.2.4 15:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:58 INFO - Downloading blobuploader-1.2.4.tar.gz 15:45:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:45:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:45:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:45:58 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 15:45:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:45:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:45:59 INFO - Downloading docopt-0.6.1.tar.gz 15:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:45:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 15:45:59 INFO - Installing collected packages: blobuploader, requests, docopt 15:45:59 INFO - Running setup.py install for blobuploader 15:45:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:45:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 15:45:59 INFO - Running setup.py install for requests 15:45:59 INFO - Running setup.py install for docopt 15:45:59 INFO - Successfully installed blobuploader requests docopt 15:45:59 INFO - Cleaning up... 15:45:59 INFO - Return code: 0 15:45:59 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:45:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:45:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:45:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:45:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f063f469f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:45:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:45:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:45:59 INFO - Using env: {'DISPLAY': ':0', 15:45:59 INFO - 'HOME': '/home/cltbld', 15:45:59 INFO - 'LANG': 'en_US.UTF-8', 15:45:59 INFO - 'LANGUAGE': 'en_US:en', 15:45:59 INFO - 'LOGNAME': 'cltbld', 15:45:59 INFO - 'MAIL': '/var/mail/cltbld', 15:45:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:45:59 INFO - 'MOZ_NO_REMOTE': '1', 15:45:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:45:59 INFO - 'NO_EM_RESTART': '1', 15:45:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:45:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:45:59 INFO - 'PWD': '/builds/slave/test-pgo', 15:45:59 INFO - 'SHELL': '/bin/bash', 15:45:59 INFO - 'SHLVL': '1', 15:45:59 INFO - 'TERM': 'linux', 15:45:59 INFO - 'TMOUT': '86400', 15:45:59 INFO - 'USER': 'cltbld', 15:45:59 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:45:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:45:59 INFO - '_': '/tools/buildbot/bin/python'} 15:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:46:00 INFO - Running setup.py (path:/tmp/pip-9GbEBV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:46:00 INFO - Running setup.py (path:/tmp/pip-byyXcJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:46:00 INFO - Running setup.py (path:/tmp/pip-8n6YvY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:46:00 INFO - Running setup.py (path:/tmp/pip-BiCpwK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:46:00 INFO - Running setup.py (path:/tmp/pip-W5DwCw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:46:00 INFO - Running setup.py (path:/tmp/pip-rqZ5Ip-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:46:00 INFO - Running setup.py (path:/tmp/pip-gZsrP0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:46:00 INFO - Running setup.py (path:/tmp/pip-7X0oKn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:46:00 INFO - Running setup.py (path:/tmp/pip-pByJ7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:46:00 INFO - Running setup.py (path:/tmp/pip-zf9qtV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:46:00 INFO - Running setup.py (path:/tmp/pip-GAj7mC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:46:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:46:00 INFO - Running setup.py (path:/tmp/pip-K21YZN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:46:01 INFO - Running setup.py (path:/tmp/pip-ClVRzw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:46:01 INFO - Running setup.py (path:/tmp/pip-iN4OYW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:46:01 INFO - Running setup.py (path:/tmp/pip-rgTo0y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:46:01 INFO - Running setup.py (path:/tmp/pip-vbZsJa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:46:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:46:01 INFO - Running setup.py (path:/tmp/pip-_1gfs0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:46:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:46:01 INFO - Running setup.py install for manifestparser 15:46:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 15:46:01 INFO - Running setup.py install for mozcrash 15:46:01 INFO - Running setup.py install for mozdebug 15:46:01 INFO - Running setup.py install for mozdevice 15:46:01 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 15:46:01 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 15:46:01 INFO - Running setup.py install for mozfile 15:46:01 INFO - Running setup.py install for mozhttpd 15:46:01 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Running setup.py install for mozinfo 15:46:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Running setup.py install for mozInstall 15:46:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Running setup.py install for mozleak 15:46:02 INFO - Running setup.py install for mozlog 15:46:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Running setup.py install for moznetwork 15:46:02 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Running setup.py install for mozprocess 15:46:02 INFO - Running setup.py install for mozprofile 15:46:02 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Running setup.py install for mozrunner 15:46:02 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 15:46:02 INFO - Running setup.py install for mozscreenshot 15:46:02 INFO - Running setup.py install for moztest 15:46:03 INFO - Running setup.py install for mozversion 15:46:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 15:46:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:46:03 INFO - Cleaning up... 15:46:03 INFO - Return code: 0 15:46:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f063f469f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:46:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 15:46:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:46:03 INFO - Using env: {'DISPLAY': ':0', 15:46:03 INFO - 'HOME': '/home/cltbld', 15:46:03 INFO - 'LANG': 'en_US.UTF-8', 15:46:03 INFO - 'LANGUAGE': 'en_US:en', 15:46:03 INFO - 'LOGNAME': 'cltbld', 15:46:03 INFO - 'MAIL': '/var/mail/cltbld', 15:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:03 INFO - 'MOZ_NO_REMOTE': '1', 15:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:03 INFO - 'NO_EM_RESTART': '1', 15:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:03 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:03 INFO - 'SHELL': '/bin/bash', 15:46:03 INFO - 'SHLVL': '1', 15:46:03 INFO - 'TERM': 'linux', 15:46:03 INFO - 'TMOUT': '86400', 15:46:03 INFO - 'USER': 'cltbld', 15:46:03 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:03 INFO - '_': '/tools/buildbot/bin/python'} 15:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:46:03 INFO - Running setup.py (path:/tmp/pip-8rTYsv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 15:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 15:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:46:03 INFO - Running setup.py (path:/tmp/pip-WqL1Fv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 15:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:46:03 INFO - Running setup.py (path:/tmp/pip-RFHLdo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 15:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:46:03 INFO - Running setup.py (path:/tmp/pip-U0Sj62-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 15:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 15:46:03 INFO - Running setup.py (path:/tmp/pip-FVe1yU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 15:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 15:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:46:03 INFO - Running setup.py (path:/tmp/pip-n_GK2W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 15:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 15:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:46:03 INFO - Running setup.py (path:/tmp/pip-9i0FuG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 15:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 15:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:46:03 INFO - Running setup.py (path:/tmp/pip-mtGd2k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 15:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 15:46:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 15:46:03 INFO - Running setup.py (path:/tmp/pip-P7D99v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 15:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 15:46:04 INFO - Running setup.py (path:/tmp/pip-k__AuO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:46:04 INFO - Running setup.py (path:/tmp/pip-pSDNOB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 15:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:46:04 INFO - Running setup.py (path:/tmp/pip-dYQv4o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 15:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:46:04 INFO - Running setup.py (path:/tmp/pip-LZkziR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 15:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:46:04 INFO - Running setup.py (path:/tmp/pip-feVnkJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 15:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:46:04 INFO - Running setup.py (path:/tmp/pip-QCD3O3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 15:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 15:46:04 INFO - Running setup.py (path:/tmp/pip-EvozVz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 15:46:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 15:46:04 INFO - Running setup.py (path:/tmp/pip-K7Z1e1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 15:46:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 15:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:06 INFO - Downloading blessings-1.5.1.tar.gz 15:46:06 INFO - Storing download in cache at /builds/slave/test-pgo/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 15:46:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 15:46:06 INFO - Installing collected packages: blessings 15:46:06 INFO - Running setup.py install for blessings 15:46:06 INFO - Successfully installed blessings 15:46:06 INFO - Cleaning up... 15:46:06 INFO - Return code: 0 15:46:06 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 15:46:06 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:46:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:46:06 INFO - Reading from file tmpfile_stdout 15:46:06 INFO - Current package versions: 15:46:06 INFO - argparse == 1.2.1 15:46:06 INFO - blessings == 1.5.1 15:46:06 INFO - blobuploader == 1.2.4 15:46:06 INFO - docopt == 0.6.1 15:46:06 INFO - manifestparser == 1.1 15:46:06 INFO - mozInstall == 1.12 15:46:06 INFO - mozcrash == 0.16 15:46:06 INFO - mozdebug == 0.1 15:46:06 INFO - mozdevice == 0.47 15:46:06 INFO - mozfile == 1.2 15:46:06 INFO - mozhttpd == 0.7 15:46:06 INFO - mozinfo == 0.9 15:46:06 INFO - mozleak == 0.1 15:46:06 INFO - mozlog == 3.1 15:46:06 INFO - moznetwork == 0.27 15:46:06 INFO - mozprocess == 0.22 15:46:06 INFO - mozprofile == 0.28 15:46:06 INFO - mozrunner == 6.11 15:46:06 INFO - mozscreenshot == 0.1 15:46:06 INFO - mozsystemmonitor == 0.0 15:46:06 INFO - moztest == 0.7 15:46:06 INFO - mozversion == 1.4 15:46:06 INFO - psutil == 3.1.1 15:46:06 INFO - requests == 1.2.3 15:46:06 INFO - wsgiref == 0.1.2 15:46:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 15:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f063f469f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:46:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 15:46:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:46:06 INFO - Using env: {'DISPLAY': ':0', 15:46:06 INFO - 'HOME': '/home/cltbld', 15:46:06 INFO - 'LANG': 'en_US.UTF-8', 15:46:06 INFO - 'LANGUAGE': 'en_US:en', 15:46:06 INFO - 'LOGNAME': 'cltbld', 15:46:06 INFO - 'MAIL': '/var/mail/cltbld', 15:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:06 INFO - 'MOZ_NO_REMOTE': '1', 15:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:06 INFO - 'NO_EM_RESTART': '1', 15:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:06 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:06 INFO - 'SHELL': '/bin/bash', 15:46:06 INFO - 'SHLVL': '1', 15:46:06 INFO - 'TERM': 'linux', 15:46:06 INFO - 'TMOUT': '86400', 15:46:06 INFO - 'USER': 'cltbld', 15:46:06 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:06 INFO - '_': '/tools/buildbot/bin/python'} 15:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 15:46:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 15:46:06 INFO - Cleaning up... 15:46:06 INFO - Return code: 0 15:46:06 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 15:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f063f469f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:46:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 15:46:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:46:06 INFO - Using env: {'DISPLAY': ':0', 15:46:06 INFO - 'HOME': '/home/cltbld', 15:46:06 INFO - 'LANG': 'en_US.UTF-8', 15:46:06 INFO - 'LANGUAGE': 'en_US:en', 15:46:06 INFO - 'LOGNAME': 'cltbld', 15:46:06 INFO - 'MAIL': '/var/mail/cltbld', 15:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:06 INFO - 'MOZ_NO_REMOTE': '1', 15:46:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:06 INFO - 'NO_EM_RESTART': '1', 15:46:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:06 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:06 INFO - 'SHELL': '/bin/bash', 15:46:06 INFO - 'SHLVL': '1', 15:46:06 INFO - 'TERM': 'linux', 15:46:06 INFO - 'TMOUT': '86400', 15:46:06 INFO - 'USER': 'cltbld', 15:46:06 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:06 INFO - '_': '/tools/buildbot/bin/python'} 15:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:07 INFO - Downloading/unpacking jsonschema 15:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:46:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 15:46:08 INFO - Downloading/unpacking functools32 (from jsonschema) 15:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:09 INFO - Downloading functools32-3.2.3-2.tar.gz 15:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 15:46:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 15:46:09 INFO - warning: no files found matching '*.txt' 15:46:09 INFO - no previously-included directories found matching 'build' 15:46:09 INFO - no previously-included directories found matching 'dist' 15:46:09 INFO - no previously-included directories found matching '.git*' 15:46:09 INFO - Installing collected packages: jsonschema, functools32 15:46:09 INFO - Running setup.py install for functools32 15:46:09 INFO - warning: no files found matching '*.txt' 15:46:09 INFO - no previously-included directories found matching 'build' 15:46:09 INFO - no previously-included directories found matching 'dist' 15:46:09 INFO - no previously-included directories found matching '.git*' 15:46:09 INFO - Successfully installed jsonschema functools32 15:46:09 INFO - Cleaning up... 15:46:09 INFO - Return code: 0 15:46:09 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 15:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:46:09 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f063f469f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x298d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a5a480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}], 'cwd': '/builds/slave/test-pgo/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 15:46:09 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 15:46:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 15:46:09 INFO - Using env: {'DISPLAY': ':0', 15:46:09 INFO - 'HOME': '/home/cltbld', 15:46:09 INFO - 'LANG': 'en_US.UTF-8', 15:46:09 INFO - 'LANGUAGE': 'en_US:en', 15:46:09 INFO - 'LOGNAME': 'cltbld', 15:46:09 INFO - 'MAIL': '/var/mail/cltbld', 15:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:09 INFO - 'MOZ_NO_REMOTE': '1', 15:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:09 INFO - 'NO_EM_RESTART': '1', 15:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:09 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:09 INFO - 'SHELL': '/bin/bash', 15:46:09 INFO - 'SHLVL': '1', 15:46:09 INFO - 'TERM': 'linux', 15:46:09 INFO - 'TMOUT': '86400', 15:46:09 INFO - 'USER': 'cltbld', 15:46:09 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:09 INFO - '_': '/tools/buildbot/bin/python'} 15:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:46:09 INFO - Downloading/unpacking flake8 15:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 15:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 15:46:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 15:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 15:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 15:46:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 15:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 15:46:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 15:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:46:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 15:46:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 15:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:46:11 INFO - no previously-included directories found matching 'docs/_build' 15:46:11 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 15:46:11 INFO - Running setup.py install for pep8 15:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 15:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 15:46:11 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 15:46:11 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 15:46:11 INFO - no previously-included directories found matching 'docs/_build' 15:46:12 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 15:46:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 15:46:12 INFO - Cleaning up... 15:46:12 INFO - Return code: 0 15:46:12 INFO - Running post-action listener: _resource_record_post_action 15:46:12 INFO - Running post-action listener: _start_resource_monitoring 15:46:12 INFO - Starting resource monitoring. 15:46:12 INFO - ##### 15:46:12 INFO - ##### Running install step. 15:46:12 INFO - ##### 15:46:12 INFO - Running pre-action listener: _resource_record_pre_action 15:46:12 INFO - Running main action method: install 15:46:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 15:46:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 15:46:12 INFO - Reading from file tmpfile_stdout 15:46:12 INFO - Detecting whether we're running mozinstall >=1.0... 15:46:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 15:46:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 15:46:12 INFO - Reading from file tmpfile_stdout 15:46:12 INFO - Output received: 15:46:12 INFO - Usage: mozinstall [options] installer 15:46:12 INFO - Options: 15:46:12 INFO - -h, --help show this help message and exit 15:46:12 INFO - -d DEST, --destination=DEST 15:46:12 INFO - Directory to install application into. [default: 15:46:12 INFO - "/builds/slave/test-pgo"] 15:46:12 INFO - --app=APP Application being installed. [default: firefox] 15:46:12 INFO - mkdir: /builds/slave/test-pgo/build/application 15:46:12 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 15:46:12 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 15:46:28 INFO - Reading from file tmpfile_stdout 15:46:28 INFO - Output received: 15:46:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 15:46:28 INFO - Running post-action listener: _resource_record_post_action 15:46:28 INFO - ##### 15:46:28 INFO - ##### Running run-tests step. 15:46:28 INFO - ##### 15:46:28 INFO - Running pre-action listener: _resource_record_pre_action 15:46:28 INFO - Running main action method: run_tests 15:46:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 15:46:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 15:46:28 INFO - Python 2.7.3 15:46:28 INFO - Return code: 0 15:46:28 INFO - grabbing minidump binary from tooltool 15:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:46:28 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9660>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aea560>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2aeaa10>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 15:46:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 15:46:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 15:46:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:46:28 INFO - Return code: 0 15:46:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 15:46:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 15:46:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 15:46:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 15:46:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 15:46:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 15:46:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 15:46:29 INFO - Return code: 0 15:46:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 15:46:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 15:46:29 INFO - Using env: {'DISPLAY': ':0', 15:46:29 INFO - 'HOME': '/home/cltbld', 15:46:29 INFO - 'LANG': 'en_US.UTF-8', 15:46:29 INFO - 'LANGUAGE': 'en_US:en', 15:46:29 INFO - 'LOGNAME': 'cltbld', 15:46:29 INFO - 'MAIL': '/var/mail/cltbld', 15:46:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:46:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 15:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:46:29 INFO - 'MOZ_NO_REMOTE': '1', 15:46:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 15:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:46:29 INFO - 'NO_EM_RESTART': '1', 15:46:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 15:46:29 INFO - 'PWD': '/builds/slave/test-pgo', 15:46:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 15:46:29 INFO - 'SHELL': '/bin/bash', 15:46:29 INFO - 'SHLVL': '1', 15:46:29 INFO - 'TERM': 'linux', 15:46:29 INFO - 'TMOUT': '86400', 15:46:29 INFO - 'USER': 'cltbld', 15:46:29 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158', 15:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:46:29 INFO - '_': '/tools/buildbot/bin/python'} 15:46:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 15:46:29 INFO - mozversion application_buildid: 20151231133003 15:46:29 INFO - mozversion application_changeset: 917f28fafccf95dc451ea390d0132814bf0081f4 15:46:29 INFO - mozversion application_display_name: Nightly 15:46:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:46:29 INFO - mozversion application_name: Firefox 15:46:29 INFO - mozversion application_remotingname: firefox 15:46:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:46:29 INFO - mozversion application_vendor: Mozilla 15:46:29 INFO - mozversion application_version: 46.0a1 15:46:29 INFO - mozversion platform_buildid: 20151231133003 15:46:29 INFO - mozversion platform_changeset: 917f28fafccf95dc451ea390d0132814bf0081f4 15:46:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 15:46:29 INFO - mozversion platform_version: 46.0a1 15:46:29 INFO - using testdate: 1451605589 15:46:29 INFO - actual date: 1451605589 15:46:29 INFO - starting webserver on 'localhost:45867' 15:46:29 INFO - SUITE-START | Running 3 tests 15:46:29 INFO - TEST-START | dromaeo_css 15:46:29 INFO - operating with platform_type : linux_ 15:46:29 INFO - Initialising browser for dromaeo_css test... 15:46:29 INFO - TEST-INFO | started process 6491 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo7PUSh/profile http://localhost:45867/getInfo.html) 15:46:34 INFO - PROCESS | 6491 | __metrics Screen width/height:1600/1200 15:46:34 INFO - PROCESS | 6491 | colorDepth:24 15:46:34 INFO - PROCESS | 6491 | Browser inner width/height: 1024/697 15:46:34 INFO - PROCESS | 6491 | __metrics 15:46:34 INFO - PROCESS | 6491 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 15:46:35 INFO - TEST-INFO | 6491: exit 0 15:46:35 INFO - Browser initialized. 15:46:35 INFO - Running cycle 1/1 for dromaeo_css test... 15:46:35 INFO - TEST-INFO | started process 6626 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo7PUSh/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:46:46 INFO - PROCESS | 6626 | RSS: Main: 150032384 15:46:46 INFO - PROCESS | 6626 | 15:47:36 INFO - PROCESS | 6626 | 1451605656559 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:49:45 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45867/tests/dromaeo/cssquery-ext.html) 15:49:47 INFO - PROCESS | 6626 | RSS: Main: 157257728 15:49:47 INFO - PROCESS | 6626 | 15:52:49 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-ext.html (next: http://localhost:45867/tests/dromaeo/cssquery-jquery.html) 15:52:49 INFO - PROCESS | 6626 | RSS: Main: 152784896 15:52:49 INFO - PROCESS | 6626 | 15:55:51 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45867/tests/dromaeo/cssquery-mootools.html) 15:55:52 INFO - PROCESS | 6626 | RSS: Main: 153911296 15:55:52 INFO - PROCESS | 6626 | 15:58:53 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45867/tests/dromaeo/cssquery-prototype.html) 15:58:54 INFO - PROCESS | 6626 | RSS: Main: 152272896 15:58:54 INFO - PROCESS | 6626 | 16:01:56 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45867/tests/dromaeo/cssquery-yui.html) 16:01:57 INFO - PROCESS | 6626 | RSS: Main: 152809472 16:01:57 INFO - PROCESS | 6626 | 16:04:59 INFO - PROCESS | 6626 | Cycle 1(1): loaded http://localhost:45867/tests/dromaeo/cssquery-yui.html (next: http://localhost:45867/tests/dromaeo/cssquery-dojo.html) 16:04:59 INFO - PROCESS | 6626 | RSS: Main: 155160576 16:04:59 INFO - PROCESS | 6626 | 16:04:59 INFO - PROCESS | 6626 | __start_tp_report 16:04:59 INFO - PROCESS | 6626 | _x_x_mozilla_page_load 16:04:59 INFO - PROCESS | 6626 | _x_x_mozilla_page_load_details 16:04:59 INFO - PROCESS | 6626 | |i|pagename|runs| 16:04:59 INFO - PROCESS | 6626 | |0;dojo.html;3144.449721298773;3188.569543111679;3226.709596136347;3240.497722852957;3242.432574299497;5257.973710131444;5375.48932851379;5386.622936394449;5402;5407.134858422653;5324.174752913295;5333;5385.192221166817;5407.188921661753;5433.891322173564;4627.699199552018;4884.218525035995;5046.52058054486;5057.0897238497055;5075.340205773245;4809.446913604946;4951.257311403282;5004.224345226496;5015.648904576681;5053.696778193302;4861.124997500448;4863.319135321076;4936.136176169192;4981.227909674007;4986.4764199758865;4806.375171227753;4809.132293288633;4826.420829500483;4839.951600483985;4864.878378040542;4763.785629646674;4821.252705830602;4829.420469543642;4835.153848076572;4844.612431005511;5196.53231209193;5212.582993360522;5226.764795584169;5237.973810130925;5254.605904557174;5780.3063632363965;5787.623804452697;5789.247397838254;5790.04464263396;5805.535557155417;5663.377028526858;5765.769369225226;5820.243368362128;5821.912671309934;5860.736266868002;5325.121354976385;5335;5338.679679219259;5364.409914909357;5371.623986320959;5842.912356314659;5843.853903652443;5851.824445266649;5854.765809367663;5869.735861886225;5547.611667183259;5597.188407680864;5631.493165615032;5695.031844586348;5706.001449746278;5852;5862.472377486047;5871.119332100219;5893.734781934823;5897.174395584621;5799.536037117021;5849.532037436995;5856.355800861902;5865.149553314745;5868.911966320508;5564.054110801174;5656.066748986371;5736.569757268222;5863.882722345615;5864.648121112747;4473.5526447355005;4481.395011673448;4505.144022635689;4509.030558429953;4511.345854851028;3958.5447673517915;3998.420229066769;4017.276890159741;4044.838206471708;4045.9797701011307;5268.9736551317;5377.704226267515;5395.81114660985;5514.531264842453;5535.308086489189;5811.82564523065;5889.764409423575;5897.64614123154;5915.911261331084;5920.2895652521975;5240.423553409122;5476.835694929079;5488.9725551372785;5495.945040549544;5498.285222921075;4867.221244600847;4894.363732714795;4957.405111386584;4959.330490383752;5003.049420610072;5985;6046.395360463918;6059.0608455689435;6060.666663333559;6074.3925607438905;5581.10702287632;5653.067243904709;5775.33583637887;5829.562782791223;5832.300123984979;6036.7283472244735;6124.869201255597;6129.603311142587;6135.680249343183;6142.802153580009;5804.390538993345;5828.912566311424;5855.765769369177;5867.794627188198;5885;5642.492175704207;5752.597318187687;5795.8551036224435;5925.851853703692;5948.643081415129;5540.113581826889;5554.361248456479;5568.777248909998;5580.414056524169;5608.270924779753;5570;5570.5543556516195;5575.498205161555;5584.46947539983;5588.636738611977;5459.699716515471;5503.724813759376;5531.695756733418;5540.972295138659;5615.0173719599725;5692.260006199168;5748.827535173951;5774.566907481872;5776.682282474504;5793.884122317614;5593.328800543798;5597.860053498533;5641.633293835887;5644.774209031592;5651 16:04:59 INFO - PROCESS | 6626 | |1;ext.html;525.9953488836323;540.3299908113938;558.7876606889382;568.9573282003851;569.35947059558;35061;35493.2901341973;35752.2849543009;35800.82099589505;35997.99999999997;39047.43810247587;39612;39623.207535849266;39636.20727585454;39773.60226397735;8541.316694664427;8679.132086791333;8685.696000639979;8688.739337819876;8690.391672582922;8421.873671894926;8610.741677749646;8634.784130396727;8837.248833849131;8838.29293656506;8846.955765221164;8880.978687450928;8903.95548022259;8912.108789121101;8912.688055918044;8738.519381434018;8754.343424243143;8814.294856411536;8814.779630509225;8839.558022098901;8583.18459746323;8722.476651400873;8739.563021848882;8749.737507874774;8767.473951562863;39110.41334379987;39683.40474892879;39796.80101599474;39842.601573984466;39888.60111398907;2728.741488170169;2895.2327633177224;2987.1635941936293;3084.090193392932;3180.3321302526497;26169.345766355993;26400.86799566009;26816.59775103375;26966.865165674244;27158.728412715816;3522.6477352264824;3563.2873425314783;3603.081214290339;3676.7793932364143;3684.0973961379364;180714.096429517;181408;182029;182479.99999999866;182927.99999999866;40891.59108408937;49521.50478495241;54563.727181363836;54612.18081728777;54628;39830;39834.800825996266;39947.40078898819;40167.1966560673;40198.79900600478;13576.93211533936;13742.587722368346;13775.724485510234;13815.102018368974;13851.653708657364;11654.76690466186;11783.234089784137;11795.52817887292;11797.88202117968;11800.704982375337;13957.302134893214;14045.087069340665;14456.204908729911;14499.492517761828;14538.781918271234;5778.295402856167;5835.387284335168;5857.912131318034;5877.9118313225335;5959.433853783884;923.8845144356956;961.7355227312405;1068.8663917010374;1112.8386383974278;1130.2370899642708;30666;32315.838420807744;33950.320993580484;34129;34339.82830085883;968.8982656821073;976.8827740671165;1004.8191325561469;1030.5362586835954;1168.2756690851556;14422.134671919508;14742.852571474363;14769.704605908037;14834;14837.62905927339;749745;759088;767194;769800;773303;55128;55265;55522.44477555253;55632.16551751727;55681.44318556762;1312.9803052954214;1390.0686540018212;1390.6245313765228;1397.573740009307;1401.3203596255807;28488.430231395672;29960.550591740706;30092.849535752182;30105.698943011164;30318.696813031587;46123.53876461193;46205.30692039689;46321;46531.302030470244;46559.30161047655;232405;233350;233768;234012;234736;31984.68015319817;42924.57075429206;42942.57057429386;44128;44132.33801492916;41723.7913810429;42535.149297014505;42862.35706464468;43031;43621;36081.639183607826;36132.09669758172;36325.818370907975;36953.07617309589;37333.6266637341;36010.77898098666;36264.81867590751;36294;36401.817990909876;36584;34657.826710866284;35741;35947.10132246715;36034.819825900704;36039.63960360468;30205;33131.50302745413;33546.49680254847;33609.327813444084;33642.3271534563;25102.24693259205;25109.372265693502;25350.619740704275;25467.73081879076;25620.8718956404 16:04:59 INFO - PROCESS | 6626 | |2;jquery.html;369.06258104414786;369.3665363900909;369.51039872169383;370.4887255587289;374.65906025516784;16469.75295370569;17378.65242695147;17440.127993600334;18010.72983905241;18148.546286342847;11120.721981950435;11577.942110289438;13221.20672759635;13224.735505289913;13260.1380910241;4855.490173531773;4910.8281210157475;5039.974800126012;5053.949460505403;5057.41839688435;5036.043151801146;5042.873928151789;5057.822976195834;5058.645894787366;5063.898722025558;3599.1002249437643;3705.0366904604725;5006.824761133361;5013.674111182761;5019.6988180709095;5383.596230282725;5564.33228012641;5568.972155139199;5569.415211402805;5578.163275508666;5254.474552544753;5339.305890234284;5339.5728341732565;5347.812826551091;5361.678299302054;19740;19743;20085.39743807688;20321.695174572393;20426.79573204264;1956.5695546979641;1989.8109679580416;2086.1863873089505;2163.5132095278595;2263.7509873913855;12835.229886206858;13166.414208916218;13275.933620331933;13308.534201303004;13327.533536326182;1776.085316062229;1789.818719645028;1802.8557715382738;1815.1831675745966;1834.6514162309118;53380;54808.451915480735;57878.42121578773;59072.40927590712;59161.408385916024;9946.35348702332;10267;10353.74115647115;10356.119729823049;10398.272120951611;13402.463901443833;13461.326933653474;13475;13478;13502.257375844227;7267.345938865527;7379.262073792685;7403.8149046274275;7423.962880185564;7498.887516687254;7002.299770022957;7009.7897063088185;7026.718931242795;7039.753608623673;7085.43316534676;4404.185225733249;4496.168208881302;4504.1087136680935;4507.549245075466;4513.300438432048;1834.559705670656;1865.4217192670317;1894.687376582876;1902.876313039648;1912.0726447672866;448.2894612039888;457.69334545854355;947.8957314695378;997.9950100249453;1048.9423081730579;10732.946335268274;10977.890221097687;11118.221724479208;11186.32882027081;11266.211365204357;458.47046661106475;463.1709240459607;465.2137886971008;469.4319872953696;472.27270004193844;5862.912056319158;6044.335123136451;6086.726097325631;6089.117078023751;6151.5386346024225;508123;522897;525629;528755;585752;78977.60511197407;79677.60161199157;81060.59469702732;81132;82306.58846705848;486.642317896353;492.0503428383255;492.50257240186954;493.57799081784555;495.25958691756773;9774.169195618168;10063.245256605638;10157.9492102539;10175.7456063599;10266.332688375232;31794.364112717154;32012.67987320097;32056.198595035312;32493;32823.50764738483;44207.77896110499;45569;45615.54384456113;45750.54249457463;46575.301370478795;8951.507667078373;9627.085426884434;9733.221342292458;9733.270004749531;9823.557939892578;16284.592885177492;17218.65562688764;17454.127293635014;17492.300307987538;17517.386891458736;14003.579892603238;14489.058211216237;14521.346539405964;14647.487337943121;14829.851701483278;12869.871301287241;13858.4456621734;14096.929515352767;14123.152610843383;14578.125312481285;14509.419623215375;14768.187749673441;14783.113231407116;14882.553523394316;15087.396504139711;9519.714408567754;9586.089321514444;9869.457179855177;9884.30809843304;9902.900970990198;14772.55682329532;14840;14975.775363369776;15018.324175411914;15153.621159471102 16:04:59 INFO - PROCESS | 6626 | |3;mootools.html;1475.970480590388;1494.0960718765148;1661.169415292353;1807.2138619700422;1825.1072050799482;7399.630018499074;7477.813054673636;7572.432067594938;7638.618069096544;7648.770536883895;7145.392641625468;7149.249328820477;7200.315969982843;7206.639668016604;7212.927870721304;2235.16181431963;2269.1944359752297;2269.693591365169;2281.669157972093;2282.897269622871;2280.1905323610044;2280.2247235939776;2357;2361.1027809432476;2363.822713296501;2259.1302348595827;2270.693456383384;2289.9656505152434;2303.49323148907;2314.0281081945623;2260.400993736661;2275.226423016174;2304.5275718477674;2312.317866229458;2326.47654277787;2283.6917016202765;2339.7075365579303;2341.0635745701684;2346.9061237550477;2354.0348457132495;7033.718651253944;7086.610236436994;7099.964500177518;7108.502404831664;7115.1461824580865;4582.702124361906;4703.318018887277;4707.223308154151;4717.882052948669;4730.62155027597;3040.9847950760327;3068.8772449102235;3162.810231386124;3163.0510846746115;3164.5727826743555;963.4604621411962;988.4662282367512;1002.8144793213206;1010.2221289606962;1037.678319720889;10179.643712470102;10250.7437314067;10312.896871031344;10346.637867674595;10370.585176592927;4120.402541631506;4197.643200327945;4204.285271503852;4263.360495925636;4269.786510674454;8454.746357609281;8526.190011948855;8535.743927682179;8543.615537300711;8550.871736923827;4608.663487588562;4667.533246675305;4669.34629151919;4689.60138388234;4690.835820746258;4280.379344994958;4282.443282373271;4293.355996600535;4296.269634162138;4319.352097185384;3356.295178012596;3380.678835510623;3403.7957722536726;3408.6932176103774;3412.6416726243388;1110.8278216876397;1116.2465335898237;1116.436199719153;1120.383788916093;1121.058311018748;999.3953658036928;1000.6747806962766;1086.5708045322053;1088.374184843718;1233.8272641830151;6937.89593156093;6951.548149370275;6971.093757811452;6975.232724400312;6997.545159564714;1091.9945400272948;1092.1153865369076;1120.260627985542;1130.2653275371074;1136.8124259497256;5635.520980716603;5724.112762521816;5732.054211055212;5737.655740655574;5738.311402631711;8745.693900713444;9113.544322783835;9170.633174673072;9176.128267814547;9252.90747092534;9012.459252444874;9044.231240344512;9093.40892841963;9136.725898223063;9138.54307284633;6830.077939478207;6911.308869113149;6934.826629334307;6975.895361569581;6982.61595612236;6433.163688720437;6455.096286519797;6461.709223085067;6493.448056915215;6495.350464953467;7761.379089672925;7884.921150788418;7915.604219789103;7960.800979975547;7974.481658692166;7969.880451793344;8108.189181081844;8130.67477300925;8135.67457301725;8230.300424463987;6274.121622972696;6350.301466838737;6506.512011599054;6650.767223147167;6658.334166583303;7150.249223831423;7188.8921666174;7197.964010179916;7202.96398518004;7214.242504537158;6136.386361363828;6657.633830139195;6823.624700641512;6875.140607424072;6930.549514281757;6551.574147680385;6572.507061970467;6659.334066593302;6800.693968771318;6954.582725036514;6819.488538359742;6900.758473453405;6910.412614927787;6911.274316196727;6945.861082778417;6404.903926441014;6409.583377080475;6414.679266036586;6419.037144428186;6419.679016049272;5959.135925290895;6031.5476339273855;6259.311475737756;6274.749010039547;6336.968315158395 16:04:59 INFO - PROCESS | 6626 | |4;prototype.html;343.0754117652926;353.330438818439;357.90873327301534;364.5570631682507;368.3590552438754;6110.725017374218;6171.074338849175;6197.3492783257725;6229.096780966757;6269.905951410721;6160.722767475463;6191.442770150686;6194.504439644829;6220.9377906220925;6228.346023667517;4743.573078422941;4761.000189960113;4771.689840160396;4777.80888764449;4777.972735861789;4742.478327383985;4780.330753694486;4782.736949467778;4789.976050119762;4799.808007679689;4568.360429539867;4621.145088158702;4666.113438446701;4669.392978912737;4702.130105930397;4658.254679251338;4680.648951328664;4684.0397718467975;4689.742064186468;4691.812327506896;4088.8160032798296;4100.220958017997;4112.650424713903;4113.053997580543;4128.876133715993;5852.502537284294;5884.941150588482;5885.8822823543715;5889.087191485327;5894.410558944114;5309;5440.863978400532;5466.972665136688;5470.8085217017215;5483.670979741229;6509.41415272623;6520.413162815369;6530.412262896362;6534.901976470357;6547.705353259114;4535.727856328631;4535.9546404536195;4537.77311134442;4539.070894869667;4544.18204723153;6759.93240067598;6789.864202715918;6821.317868213188;6823.249442561314;6868.347506986828;4673.439187297546;4697.412823397075;4722.952770472251;4725.432948046187;4727.338172655831;4718.4809670936165;4738.881527961828;4742.454617718938;4744.051189761993;4749.026449577828;5464.9453505464435;5467.343918729698;5470.835874923759;5475.288212532425;5487.807926722546;6442.48460123189;6579.539432239697;6586.473082153416;6607.405333520006;6610.933890661032;1663.076992269278;1687.215444818141;1688.7382455719383;1691.1375198648777;1691.4249155287016;1101.9779604407868;1123.27548731068;1127.808272593661;1138.0781566930812;1146.7878442488166;6229.3770622937345;6241.656708881055;6247.406496382836;6247.781327653511;6257.499400047986;6721.7311307548125;6751.426128779109;6773.72905083801;6778.627175505395;6782.762603308861;6189.288231853305;6206.162168107338;6236.220472440945;6308.463780578702;6320.241571011508;3710.6289371062676;3722.6277372262557;3737.3272810893754;3738.12154143776;3739.9252014959548;7197.928020719831;7204.783856484314;7208.783736487913;7215.783526494213;7217.963910180415;6919.792406227822;6987.790366289019;7023.89464158038;7027.297270272932;7060.505764596429;7066.646667666596;7177.210506844243;7182.820429489305;7197.4961752677855;7215.278472152742;6857.5199736018;6859.108315918898;6866.176058872968;6866.588004719732;6884.586924784529;6719.764808231688;6733.293004234485;6814.965925170342;6822.829429264109;6822.965885170543;7184.209736929038;7196.712131514681;7203.495755297288;7207.13514378278;7219.45854060937;4641.164590373765;4663.976680116578;4702.741349225826;4708.576228139484;4709.317149013443;6694.4644428444635;6813.3527314905;6848.178218613599;6848.486363522856;6882.208546017272;6629.105070815378;6639.302873198245;6654.500912431684;6671.132752742113;6681.432078273401;6641.435477984425;6654.667266636552;6668.933310666831;6677.065210870385;6680.231773346128;6246.344133865879;6463.515236357386;6488.805335839932;6543.869122617616;6547;6691;6697.899531506934;6707.128073350434;6725.730970761115;6731.158605174353;6341.334159913143;6503.382178693017;6517.902231466626;6553.868922621426;6553.934460655523 16:04:59 INFO - PROCESS | 6626 | |5;yui.html;644.5037321262627;649.3733547127022;660.8744338575672;791.540906274361;819.4264015189373;13005.414756335964;13284.734305313888;13307.733845323088;15404.306806193721;15727;14703.705925881475;14739.778903316432;14843.109413435175;14876.330565124568;14884.553463396116;825.4015838517087;830.6760363458257;842.5829214538812;846.7417437681505;852.86780549015;836.4145098431122;838.4089217101958;841.4993079117914;842.9325653947669;846.5301757524571;872.6640243506264;879.9956000220022;880.6917578847416;882.1883866842488;883.3419102768446;870.7648934787603;877.1973644115626;879.8064425826308;880.0495464897926;881.0660699658318;649.9772507962246;650.6356440393395;654.0940796996147;654.1986067067851;655.3348351423309;13719.794203086962;13804.585862424143;13826.93086534571;13835.861641383659;13845.584632461043;10917.890821091767;11967.461464234131;12019.57931472403;12147.696307592292;12417.75164496714;9406.153446189875;9423.858642120374;9445.149936505679;9484.478353690612;10015.266870890186;3533.6819686228105;3566.732495062881;3573.3746594345885;3581.6418358164237;3587.4798154267487;46555.30167047463;46863.765681171375;47253.76373118113;47697;48099.51900480985;9553.713388598353;9571.473568953636;9772.21822254218;9805.80388392228;9887.950560247296;17906;17920.193591288422;17932.193051312723;17956.55108622295;17963.640727185382;6932.861342773116;7154.749583764543;7173.820654483679;7191.316824901626;7298.52559583636;4188.727732697365;4204.3903633972905;4339.153864996359;4355.60799528044;4367.235733746582;3060.73983711387;3082.6300843898875;3096.1949893027527;3098.798578092417;3099.9070027899197;564.3650892745661;569.7521578113534;575.23493753308;575.4073304496376;576.1099101887594;468.20639016866767;470.097412967104;473.37987236720005;478.4497827498405;489.2783144861372;7914.604269786603;8008;8110.553919534483;8262.876056859152;8267.545285009262;488.8973315603763;492.2067268252652;559.1696330948538;652.7356420649644;667.5060455263167;3580.7135429165605;3866.3040652682225;4196;4213.389058586487;4308.870733877989;54876;55227.44772552223;55308.72345638327;55573.16640250399;57055;48657;48960.51039489631;49286;49803.25295120576;50265;40224.396634050514;40445.59554404477;40811.18377632431;41006.104420080046;41020.1795964085;8342.499450033018;8675.956620216859;8739.0390032933;8888.066752990842;8993.460392376479;34787.9563613092;34953.300933981685;35441.82279088588;35870.46194307035;35895.28209435744;42884.57115428806;43415.56584434115;43762;44161;44636;10736.731581710208;10856;11097;11208.439578021229;11306.095512359156;11433.942830285796;11485.885141148816;11615.883841161818;11749.177557571229;12135.150539462153;9686.370385924893;9854.802903941738;9961.053699898497;10384.844227336747;10445.843312350169;9740.366876153028;10015.39907605546;10051.899481005388;10209.081182693297;10455.16358691318;10254.846177307198;10369.585216591251;10492.265541412027;10919.235653504178;11008.669739907815;9048.366614336934;9251.121143491358;9271.67549135777;9282.164605185566;9693.079157480028;8384.874226886725;8537.871931920901;8669;9048.638054477748;9213.953930230306 16:04:59 INFO - PROCESS | 6626 | __end_tp_report 16:04:59 INFO - PROCESS | 6626 | __start_cc_report 16:04:59 INFO - PROCESS | 6626 | _x_x_mozilla_cycle_collect,314 16:04:59 INFO - PROCESS | 6626 | __end_cc_report 16:04:59 INFO - PROCESS | 6626 | __startTimestamp1451606699893__endTimestamp 16:04:59 INFO - PROCESS | 6626 | 16:04:59 INFO - PROCESS | 6626 | ------- Summary: start ------- 16:04:59 INFO - PROCESS | 6626 | Number of tests: 6 16:04:59 INFO - PROCESS | 6626 | 16:04:59 INFO - PROCESS | 6626 | [#0] dojo.html Cycles:165 Average:5373.79 Median:5564.05 stddev:609.71 (11.0%) stddev-sans-first:585.96 16:04:59 INFO - PROCESS | 6626 | Values: 3144.4 3188.6 3226.7 3240.5 3242.4 5258.0 5375.5 5386.6 5402.0 5407.1 5324.2 5333.0 5385.2 5407.2 5433.9 4627.7 4884.2 5046.5 5057.1 5075.3 4809.4 4951.3 5004.2 5015.6 5053.7 4861.1 4863.3 4936.1 4981.2 4986.5 4806.4 4809.1 4826.4 4840.0 4864.9 4763.8 4821.3 4829.4 4835.2 4844.6 5196.5 5212.6 5226.8 5238.0 5254.6 5780.3 5787.6 5789.2 5790.0 5805.5 5663.4 5765.8 5820.2 5821.9 5860.7 5325.1 5335.0 5338.7 5364.4 5371.6 5842.9 5843.9 5851.8 5854.8 5869.7 5547.6 5597.2 5631.5 5695.0 5706.0 5852.0 5862.5 5871.1 5893.7 5897.2 5799.5 5849.5 5856.4 5865.1 5868.9 5564.1 5656.1 5736.6 5863.9 5864.6 4473.6 4481.4 4505.1 4509.0 4511.3 3958.5 3998.4 4017.3 4044.8 4046.0 5269.0 5377.7 5395.8 5514.5 5535.3 5811.8 5889.8 5897.6 5915.9 5920.3 5240.4 5476.8 5489.0 5495.9 5498.3 4867.2 4894.4 4957.4 4959.3 5003.0 5985.0 6046.4 6059.1 6060.7 6074.4 5581.1 5653.1 5775.3 5829.6 5832.3 6036.7 6124.9 6129.6 6135.7 6142.8 5804.4 5828.9 5855.8 5867.8 5885.0 5642.5 5752.6 5795.9 5925.9 5948.6 5540.1 5554.4 5568.8 5580.4 5608.3 5570.0 5570.6 5575.5 5584.5 5588.6 5459.7 5503.7 5531.7 5541.0 5615.0 5692.3 5748.8 5774.6 5776.7 5793.9 5593.3 5597.9 5641.6 5644.8 5651.0 16:04:59 INFO - PROCESS | 6626 | 16:04:59 INFO - PROCESS | 6626 | [#1] ext.html Cycles:180 Average:53939.67 Median:36363.82 stddev:128743.18 (354.0%) stddev-sans-first:129041.88 16:04:59 INFO - PROCESS | 6626 | Values: 526.0 540.3 558.8 569.0 569.4 35061.0 35493.3 35752.3 35800.8 35998.0 39047.4 39612.0 39623.2 39636.2 39773.6 8541.3 8679.1 8685.7 8688.7 8690.4 8421.9 8610.7 8634.8 8837.2 8838.3 8847.0 8881.0 8904.0 8912.1 8912.7 8738.5 8754.3 8814.3 8814.8 8839.6 8583.2 8722.5 8739.6 8749.7 8767.5 39110.4 39683.4 39796.8 39842.6 39888.6 2728.7 2895.2 2987.2 3084.1 3180.3 26169.3 26400.9 26816.6 26966.9 27158.7 3522.6 3563.3 3603.1 3676.8 3684.1 180714.1 181408.0 182029.0 182480.0 182928.0 40891.6 49521.5 54563.7 54612.2 54628.0 39830.0 39834.8 39947.4 40167.2 40198.8 13576.9 13742.6 13775.7 13815.1 13851.7 11654.8 11783.2 11795.5 11797.9 11800.7 13957.3 14045.1 14456.2 14499.5 14538.8 5778.3 5835.4 5857.9 5877.9 5959.4 923.9 961.7 1068.9 1112.8 1130.2 30666.0 32315.8 33950.3 34129.0 34339.8 968.9 976.9 1004.8 1030.5 1168.3 14422.1 14742.9 14769.7 14834.0 14837.6 749745.0 759088.0 767194.0 769800.0 773303.0 55128.0 55265.0 55522.4 55632.2 55681.4 1313.0 1390.1 1390.6 1397.6 1401.3 28488.4 29960.6 30092.8 30105.7 30318.7 46123.5 46205.3 46321.0 46531.3 46559.3 232405.0 233350.0 233768.0 234012.0 234736.0 31984.7 42924.6 42942.6 44128.0 44132.3 41723.8 42535.1 42862.4 43031.0 43621.0 36081.6 36132.1 36325.8 36953.1 37333.6 36010.8 36264.8 36294.0 36401.8 36584.0 34657.8 35741.0 35947.1 36034.8 36039.6 30205.0 33131.5 33546.5 33609.3 33642.3 25102.2 25109.4 25350.6 25467.7 25620.9 16:04:59 INFO - PROCESS | 6626 | 16:04:59 INFO - PROCESS | 6626 | [#2] jquery.html Cycles:180 Average:28068.97 Median:2389.42 stddev:87451.74 (3660.0%) stddev-sans-first:87672.33 16:04:59 INFO - PROCESS | 6626 | Values: 369.1 369.4 369.5 370.5 374.7 16469.8 17378.7 17440.1 18010.7 18148.5 11120.7 11577.9 13221.2 13224.7 13260.1 4855.5 4910.8 5040.0 5053.9 5057.4 5036.0 5042.9 5057.8 5058.6 5063.9 3599.1 3705.0 5006.8 5013.7 5019.7 5383.6 5564.3 5569.0 5569.4 5578.2 5254.5 5339.3 5339.6 5347.8 5361.7 19740.0 19743.0 20085.4 20321.7 20426.8 1956.6 1989.8 2086.2 2163.5 2263.8 12835.2 13166.4 13275.9 13308.5 13327.5 1776.1 1789.8 1802.9 1815.2 1834.7 53380.0 54808.5 57878.4 59072.4 59161.4 9946.4 10267.0 10353.7 10356.1 10398.3 13402.5 13461.3 13475.0 13478.0 13502.3 7267.3 7379.3 7403.8 7424.0 7498.9 7002.3 7009.8 7026.7 7039.8 7085.4 4404.2 4496.2 4504.1 4507.5 4513.3 1834.6 1865.4 1894.7 1902.9 1912.1 448.3 457.7 947.9 998.0 1048.9 10732.9 10977.9 11118.2 11186.3 11266.2 458.5 463.2 465.2 469.4 472.3 5862.9 6044.3 6086.7 6089.1 6151.5 508123.0 522897.0 525629.0 528755.0 585752.0 78977.6 79677.6 81060.6 81132.0 82306.6 486.6 492.1 492.5 493.6 495.3 9774.2 10063.2 10157.9 10175.7 10266.3 31794.4 32012.7 32056.2 32493.0 32823.5 44207.8 45569.0 45615.5 45750.5 46575.3 8951.5 9627.1 9733.2 9733.3 9823.6 16284.6 17218.7 17454.1 17492.3 17517.4 14003.6 14489.1 14521.3 14647.5 14829.9 12869.9 13858.4 14096.9 14123.2 14578.1 14509.4 14768.2 14783.1 14882.6 15087.4 9519.7 9586.1 9869.5 9884.3 9902.9 14772.6 14840.0 14975.8 15018.3 15153.6 16:04:59 INFO - PROCESS | 6626 | 16:04:59 INFO - PROCESS | 6626 | [#3] mootools.html Cycles:180 Average:5258.46 Median:6266.72 stddev:2653.04 (42.3%) stddev-sans-first:2645.25 16:04:59 INFO - PROCESS | 6626 | Values: 1476.0 1494.1 1661.2 1807.2 1825.1 7399.6 7477.8 7572.4 7638.6 7648.8 7145.4 7149.2 7200.3 7206.6 7212.9 2235.2 2269.2 2269.7 2281.7 2282.9 2280.2 2280.2 2357.0 2361.1 2363.8 2259.1 2270.7 2290.0 2303.5 2314.0 2260.4 2275.2 2304.5 2312.3 2326.5 2283.7 2339.7 2341.1 2346.9 2354.0 7033.7 7086.6 7100.0 7108.5 7115.1 4582.7 4703.3 4707.2 4717.9 4730.6 3041.0 3068.9 3162.8 3163.1 3164.6 963.5 988.5 1002.8 1010.2 1037.7 10179.6 10250.7 10312.9 10346.6 10370.6 4120.4 4197.6 4204.3 4263.4 4269.8 8454.7 8526.2 8535.7 8543.6 8550.9 4608.7 4667.5 4669.3 4689.6 4690.8 4280.4 4282.4 4293.4 4296.3 4319.4 3356.3 3380.7 3403.8 3408.7 3412.6 1110.8 1116.2 1116.4 1120.4 1121.1 999.4 1000.7 1086.6 1088.4 1233.8 6937.9 6951.5 6971.1 6975.2 6997.5 1092.0 1092.1 1120.3 1130.3 1136.8 5635.5 5724.1 5732.1 5737.7 5738.3 8745.7 9113.5 9170.6 9176.1 9252.9 9012.5 9044.2 9093.4 9136.7 9138.5 6830.1 6911.3 6934.8 6975.9 6982.6 6433.2 6455.1 6461.7 6493.4 6495.4 7761.4 7884.9 7915.6 7960.8 7974.5 7969.9 8108.2 8130.7 8135.7 8230.3 6274.1 6350.3 6506.5 6650.8 6658.3 7150.2 7188.9 7198.0 7203.0 7214.2 6136.4 6657.6 6823.6 6875.1 6930.5 6551.6 6572.5 6659.3 6800.7 6954.6 6819.5 6900.8 6910.4 6911.3 6945.9 6404.9 6409.6 6414.7 6419.0 6419.7 5959.1 6031.5 6259.3 6274.7 6337.0 16:04:59 INFO - PROCESS | 6626 | 16:04:59 INFO - PROCESS | 6626 | [#4] prototype.html Cycles:180 Average:5525.89 Median:6229.24 stddev:1674.63 (26.9%) stddev-sans-first:1633.52 16:04:59 INFO - PROCESS | 6626 | Values: 343.1 353.3 357.9 364.6 368.4 6110.7 6171.1 6197.3 6229.1 6269.9 6160.7 6191.4 6194.5 6220.9 6228.3 4743.6 4761.0 4771.7 4777.8 4778.0 4742.5 4780.3 4782.7 4790.0 4799.8 4568.4 4621.1 4666.1 4669.4 4702.1 4658.3 4680.6 4684.0 4689.7 4691.8 4088.8 4100.2 4112.7 4113.1 4128.9 5852.5 5884.9 5885.9 5889.1 5894.4 5309.0 5440.9 5467.0 5470.8 5483.7 6509.4 6520.4 6530.4 6534.9 6547.7 4535.7 4536.0 4537.8 4539.1 4544.2 6759.9 6789.9 6821.3 6823.2 6868.3 4673.4 4697.4 4723.0 4725.4 4727.3 4718.5 4738.9 4742.5 4744.1 4749.0 5464.9 5467.3 5470.8 5475.3 5487.8 6442.5 6579.5 6586.5 6607.4 6610.9 1663.1 1687.2 1688.7 1691.1 1691.4 1102.0 1123.3 1127.8 1138.1 1146.8 6229.4 6241.7 6247.4 6247.8 6257.5 6721.7 6751.4 6773.7 6778.6 6782.8 6189.3 6206.2 6236.2 6308.5 6320.2 3710.6 3722.6 3737.3 3738.1 3739.9 7197.9 7204.8 7208.8 7215.8 7218.0 6919.8 6987.8 7023.9 7027.3 7060.5 7066.6 7177.2 7182.8 7197.5 7215.3 6857.5 6859.1 6866.2 6866.6 6884.6 6719.8 6733.3 6815.0 6822.8 6823.0 7184.2 7196.7 7203.5 7207.1 7219.5 4641.2 4664.0 4702.7 4708.6 4709.3 6694.5 6813.4 6848.2 6848.5 6882.2 6629.1 6639.3 6654.5 6671.1 6681.4 6641.4 6654.7 6668.9 6677.1 6680.2 6246.3 6463.5 6488.8 6543.9 6547.0 6691.0 6697.9 6707.1 6725.7 6731.2 6341.3 6503.4 6517.9 6553.9 6553.9 16:04:59 INFO - PROCESS | 6626 | 16:04:59 INFO - PROCESS | 6626 | [#5] yui.html Cycles:180 Average:13360.97 Median:48378.26 stddev:15338.87 (31.7%) stddev-sans-first:15352.18 16:04:59 INFO - PROCESS | 6626 | Values: 644.5 649.4 660.9 791.5 819.4 13005.4 13284.7 13307.7 15404.3 15727.0 14703.7 14739.8 14843.1 14876.3 14884.6 825.4 830.7 842.6 846.7 852.9 836.4 838.4 841.5 842.9 846.5 872.7 880.0 880.7 882.2 883.3 870.8 877.2 879.8 880.0 881.1 650.0 650.6 654.1 654.2 655.3 13719.8 13804.6 13826.9 13835.9 13845.6 10917.9 11967.5 12019.6 12147.7 12417.8 9406.2 9423.9 9445.1 9484.5 10015.3 3533.7 3566.7 3573.4 3581.6 3587.5 46555.3 46863.8 47253.8 47697.0 48099.5 9553.7 9571.5 9772.2 9805.8 9888.0 17906.0 17920.2 17932.2 17956.6 17963.6 6932.9 7154.7 7173.8 7191.3 7298.5 4188.7 4204.4 4339.2 4355.6 4367.2 3060.7 3082.6 3096.2 3098.8 3099.9 564.4 569.8 575.2 575.4 576.1 468.2 470.1 473.4 478.4 489.3 7914.6 8008.0 8110.6 8262.9 8267.5 488.9 492.2 559.2 652.7 667.5 3580.7 3866.3 4196.0 4213.4 4308.9 54876.0 55227.4 55308.7 55573.2 57055.0 48657.0 48960.5 49286.0 49803.3 50265.0 40224.4 40445.6 40811.2 41006.1 41020.2 8342.5 8676.0 8739.0 8888.1 8993.5 34788.0 34953.3 35441.8 35870.5 35895.3 42884.6 43415.6 43762.0 44161.0 44636.0 10736.7 10856.0 11097.0 11208.4 11306.1 11433.9 11485.9 11615.9 11749.2 12135.2 9686.4 9854.8 9961.1 10384.8 10445.8 9740.4 10015.4 10051.9 10209.1 10455.2 10254.8 10369.6 10492.3 10919.2 11008.7 9048.4 9251.1 9271.7 9282.2 9693.1 8384.9 8537.9 8669.0 9048.6 9214.0 16:04:59 INFO - PROCESS | 6626 | -------- Summary: end -------- 16:04:59 INFO - PROCESS | 6626 | 16:05:00 INFO - TEST-INFO | 6626: exit 0 16:05:00 INFO - TEST-OK | dromaeo_css | took 1111073ms 16:05:00 INFO - TEST-START | kraken 16:05:00 INFO - operating with platform_type : linux_ 16:05:00 INFO - Initialising browser for kraken test... 16:05:00 INFO - TEST-INFO | started process 6864 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpciIGk2/profile http://localhost:45867/getInfo.html) 16:05:04 INFO - PROCESS | 6864 | __metrics Screen width/height:1600/1200 16:05:04 INFO - PROCESS | 6864 | colorDepth:24 16:05:04 INFO - PROCESS | 6864 | Browser inner width/height: 1024/697 16:05:04 INFO - PROCESS | 6864 | __metrics 16:05:05 INFO - PROCESS | 6864 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:05:05 INFO - TEST-INFO | 6864: exit 0 16:05:05 INFO - Browser initialized. 16:05:05 INFO - Running cycle 1/1 for kraken test... 16:05:05 INFO - TEST-INFO | started process 6986 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpciIGk2/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:05:17 INFO - PROCESS | 6986 | RSS: Main: 150130688 16:05:17 INFO - PROCESS | 6986 | 16:05:20 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45867/tests/kraken/driver.html?testName=audio-beat-detection) 16:05:20 INFO - PROCESS | 6986 | RSS: Main: 151064576 16:05:20 INFO - PROCESS | 6986 | 16:05:23 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45867/tests/kraken/driver.html?testName=audio-dft) 16:05:24 INFO - PROCESS | 6986 | RSS: Main: 151482368 16:05:24 INFO - PROCESS | 6986 | 16:05:26 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45867/tests/kraken/driver.html?testName=audio-fft) 16:05:27 INFO - PROCESS | 6986 | RSS: Main: 145809408 16:05:27 INFO - PROCESS | 6986 | 16:05:29 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45867/tests/kraken/driver.html?testName=audio-oscillator) 16:05:30 INFO - PROCESS | 6986 | RSS: Main: 146231296 16:05:30 INFO - PROCESS | 6986 | 16:05:32 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45867/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:05:33 INFO - PROCESS | 6986 | RSS: Main: 146497536 16:05:33 INFO - PROCESS | 6986 | 16:05:36 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45867/tests/kraken/driver.html?testName=imaging-darkroom) 16:05:36 INFO - PROCESS | 6986 | RSS: Main: 147935232 16:05:36 INFO - PROCESS | 6986 | 16:05:40 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45867/tests/kraken/driver.html?testName=imaging-desaturate) 16:05:40 INFO - PROCESS | 6986 | RSS: Main: 149278720 16:05:40 INFO - PROCESS | 6986 | 16:05:43 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45867/tests/kraken/driver.html?testName=json-parse-financial) 16:05:44 INFO - PROCESS | 6986 | RSS: Main: 147468288 16:05:44 INFO - PROCESS | 6986 | 16:05:45 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45867/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:05:46 INFO - PROCESS | 6986 | RSS: Main: 149204992 16:05:46 INFO - PROCESS | 6986 | 16:05:48 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:05:48 INFO - PROCESS | 6986 | RSS: Main: 149082112 16:05:48 INFO - PROCESS | 6986 | 16:05:50 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:05:51 INFO - PROCESS | 6986 | RSS: Main: 149303296 16:05:51 INFO - PROCESS | 6986 | 16:05:53 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:05:54 INFO - PROCESS | 6986 | RSS: Main: 149086208 16:05:54 INFO - PROCESS | 6986 | 16:05:57 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:05:57 INFO - PROCESS | 6986 | RSS: Main: 149381120 16:05:57 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | Cycle 1(1): loaded http://localhost:45867/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45867/tests/kraken/driver.html?testName=ai-astar) 16:05:59 INFO - PROCESS | 6986 | RSS: Main: 150126592 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | __start_tp_report 16:05:59 INFO - PROCESS | 6986 | _x_x_mozilla_page_load 16:05:59 INFO - PROCESS | 6986 | _x_x_mozilla_page_load_details 16:05:59 INFO - PROCESS | 6986 | |i|pagename|runs| 16:05:59 INFO - PROCESS | 6986 | |0;ai-astar;113;107;112;112;112;122;111;111;113;112 16:05:59 INFO - PROCESS | 6986 | |1;audio-beat-detection;156;127;161;173;134;152;153;129;178;128 16:05:59 INFO - PROCESS | 6986 | |2;audio-dft;163;162;162;162;165;161;165;173;167;162 16:05:59 INFO - PROCESS | 6986 | |3;audio-fft;75;76;75;76;72;73;76;137;75;71 16:05:59 INFO - PROCESS | 6986 | |4;audio-oscillator;97;97;141;95;97;97;139;96;96;146 16:05:59 INFO - PROCESS | 6986 | |5;imaging-gaussian-blur;110;110;110;109;110;110;110;110;110;110 16:05:59 INFO - PROCESS | 6986 | |6;imaging-darkroom;148;147;147;148;147;148;147;148;147;151 16:05:59 INFO - PROCESS | 6986 | |7;imaging-desaturate;97;96;97;97;96;96;97;96;96;97 16:05:59 INFO - PROCESS | 6986 | |8;json-parse-financial;61;59;59;60;60;62;60;59;57;57 16:05:59 INFO - PROCESS | 6986 | |9;json-stringify-tinderbox;68;69;69;69;70;68;69;70;69;69 16:05:59 INFO - PROCESS | 6986 | |10;stanford-crypto-aes;93;87;85;88;86;86;86;86;86;86 16:05:59 INFO - PROCESS | 6986 | |11;stanford-crypto-ccm;125;122;118;135;129;122;126;123;127;119 16:05:59 INFO - PROCESS | 6986 | |12;stanford-crypto-pbkdf2;141;154;145;152;151;142;152;149;160;146 16:05:59 INFO - PROCESS | 6986 | |13;stanford-crypto-sha256-iterative;71;71;70;73;69;69;68;68;68;70 16:05:59 INFO - PROCESS | 6986 | __end_tp_report 16:05:59 INFO - PROCESS | 6986 | __start_cc_report 16:05:59 INFO - PROCESS | 6986 | _x_x_mozilla_cycle_collect,726 16:05:59 INFO - PROCESS | 6986 | __end_cc_report 16:05:59 INFO - PROCESS | 6986 | __startTimestamp1451606759668__endTimestamp 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | ------- Summary: start ------- 16:05:59 INFO - PROCESS | 6986 | Number of tests: 14 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#0] ai-astar Cycles:10 Average:112.50 Median:112.00 stddev:3.75 (3.3%) stddev-sans-first:3.97 16:05:59 INFO - PROCESS | 6986 | Values: 113.0 107.0 112.0 112.0 112.0 122.0 111.0 111.0 113.0 112.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:154.50 stddev:18.81 (12.2%) stddev-sans-first:19.79 16:05:59 INFO - PROCESS | 6986 | Values: 156.0 127.0 161.0 173.0 134.0 152.0 153.0 129.0 178.0 128.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.61 (2.2%) stddev-sans-first:3.81 16:05:59 INFO - PROCESS | 6986 | Values: 163.0 162.0 162.0 162.0 165.0 161.0 165.0 173.0 167.0 162.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:19.90 (26.5%) stddev-sans-first:21.00 16:05:59 INFO - PROCESS | 6986 | Values: 75.0 76.0 75.0 76.0 72.0 73.0 76.0 137.0 75.0 71.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#4] audio-oscillator Cycles:10 Average:110.10 Median:96.50 stddev:22.09 (22.9%) stddev-sans-first:22.91 16:05:59 INFO - PROCESS | 6986 | Values: 97.0 97.0 141.0 95.0 97.0 97.0 139.0 96.0 96.0 146.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:05:59 INFO - PROCESS | 6986 | Values: 110.0 110.0 110.0 109.0 110.0 110.0 110.0 110.0 110.0 110.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.23 (0.8%) stddev-sans-first:1.30 16:05:59 INFO - PROCESS | 6986 | Values: 148.0 147.0 147.0 148.0 147.0 148.0 147.0 148.0 147.0 151.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:05:59 INFO - PROCESS | 6986 | Values: 97.0 96.0 97.0 97.0 96.0 96.0 97.0 96.0 96.0 97.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#8] json-parse-financial Cycles:10 Average:59.40 Median:60.00 stddev:1.58 (2.6%) stddev-sans-first:1.56 16:05:59 INFO - PROCESS | 6986 | Values: 61.0 59.0 59.0 60.0 60.0 62.0 60.0 59.0 57.0 57.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 16:05:59 INFO - PROCESS | 6986 | Values: 68.0 69.0 69.0 69.0 70.0 68.0 69.0 70.0 69.0 69.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#10] stanford-crypto-aes Cycles:10 Average:86.90 Median:86.00 stddev:2.28 (2.7%) stddev-sans-first:0.83 16:05:59 INFO - PROCESS | 6986 | Values: 93.0 87.0 85.0 88.0 86.0 86.0 86.0 86.0 86.0 86.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:125.50 stddev:5.02 (4.0%) stddev-sans-first:5.32 16:05:59 INFO - PROCESS | 6986 | Values: 125.0 122.0 118.0 135.0 129.0 122.0 126.0 123.0 127.0 119.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.20 Median:151.50 stddev:5.83 (3.8%) stddev-sans-first:5.37 16:05:59 INFO - PROCESS | 6986 | Values: 141.0 154.0 145.0 152.0 151.0 142.0 152.0 149.0 160.0 146.0 16:05:59 INFO - PROCESS | 6986 | 16:05:59 INFO - PROCESS | 6986 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.64 (2.3%) stddev-sans-first:1.67 16:05:59 INFO - PROCESS | 6986 | Values: 71.0 71.0 70.0 73.0 69.0 69.0 68.0 68.0 68.0 70.0 16:05:59 INFO - PROCESS | 6986 | -------- Summary: end -------- 16:05:59 INFO - PROCESS | 6986 | 16:06:00 INFO - TEST-INFO | 6986: exit 0 16:06:00 INFO - TEST-OK | kraken | took 60019ms 16:06:00 INFO - TEST-START | v8_7 16:06:00 INFO - operating with platform_type : linux_ 16:06:00 INFO - Initialising browser for v8_7 test... 16:06:00 INFO - TEST-INFO | started process 7275 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfhPpTK/profile http://localhost:45867/getInfo.html) 16:06:04 INFO - PROCESS | 7275 | __metrics Screen width/height:1600/1200 16:06:04 INFO - PROCESS | 7275 | colorDepth:24 16:06:04 INFO - PROCESS | 7275 | Browser inner width/height: 1024/697 16:06:04 INFO - PROCESS | 7275 | __metrics 16:06:05 INFO - PROCESS | 7275 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:06:05 INFO - TEST-INFO | 7275: exit 0 16:06:05 INFO - Browser initialized. 16:06:05 INFO - Running cycle 1/1 for v8_7 test... 16:06:05 INFO - TEST-INFO | started process 7396 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpfhPpTK/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:06:17 INFO - PROCESS | 7396 | RSS: Main: 149897216 16:06:17 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | Cycle 1(1): loaded http://localhost:45867/tests/v8_7/run.html (next: http://localhost:45867/tests/v8_7/run.html) 16:06:39 INFO - PROCESS | 7396 | RSS: Main: 146276352 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | __start_tp_report 16:06:39 INFO - PROCESS | 7396 | _x_x_mozilla_page_load 16:06:39 INFO - PROCESS | 7396 | _x_x_mozilla_page_load_details 16:06:39 INFO - PROCESS | 7396 | |i|pagename|runs| 16:06:39 INFO - PROCESS | 7396 | |0;Richards;166.16816218012627 16:06:39 INFO - PROCESS | 7396 | |1;DeltaBlue;188.96447467876038 16:06:39 INFO - PROCESS | 7396 | |2;Encrypt;280.2690582959641 16:06:39 INFO - PROCESS | 7396 | |3;Decrypt;5229.166666666667 16:06:39 INFO - PROCESS | 7396 | |4;RayTrace;1072.961373390558 16:06:39 INFO - PROCESS | 7396 | |5;Earley;718.9072609633357 16:06:39 INFO - PROCESS | 7396 | |6;Boyer;12207.317073170732 16:06:39 INFO - PROCESS | 7396 | |7;RegExp;26179.48717948718 16:06:39 INFO - PROCESS | 7396 | |8;Splay;609.0133982947625 16:06:39 INFO - PROCESS | 7396 | |9;NavierStokes;4845.410628019324 16:06:39 INFO - PROCESS | 7396 | __end_tp_report 16:06:39 INFO - PROCESS | 7396 | __startTimestamp1451606799422__endTimestamp 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | ------- Summary: start ------- 16:06:39 INFO - PROCESS | 7396 | Number of tests: 10 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#0] Richards Cycles:1 Average:166.17 Median:166.17 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 166.2 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#1] DeltaBlue Cycles:1 Average:188.96 Median:188.96 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 189.0 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#2] Encrypt Cycles:1 Average:280.27 Median:280.27 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 280.3 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 5229.2 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#4] RayTrace Cycles:1 Average:1072.96 Median:1072.96 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 1073.0 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#5] Earley Cycles:1 Average:718.91 Median:718.91 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 718.9 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#6] Boyer Cycles:1 Average:12207.32 Median:12207.32 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 12207.3 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#7] RegExp Cycles:1 Average:26179.49 Median:26179.49 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 26179.5 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#8] Splay Cycles:1 Average:609.01 Median:609.01 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 609.0 16:06:39 INFO - PROCESS | 7396 | 16:06:39 INFO - PROCESS | 7396 | [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 16:06:39 INFO - PROCESS | 7396 | Values: 4845.4 16:06:39 INFO - PROCESS | 7396 | -------- Summary: end -------- 16:06:39 INFO - PROCESS | 7396 | 16:06:40 INFO - TEST-INFO | 7396: exit 0 16:06:40 INFO - TEST-OK | v8_7 | took 39746ms 16:06:40 INFO - SUITE-END | took 1210s 16:06:40 INFO - Completed test suite (00:20:10) 16:06:40 INFO - Working with test: dromaeo_css 16:06:40 INFO - Generating results file: dromaeo_css 16:06:40 INFO - Working with test: kraken 16:06:40 INFO - Generating results file: kraken 16:06:40 INFO - javascript benchmark 16:06:40 INFO - Working with test: v8_7 16:06:40 INFO - Generating results file: v8_7 16:06:40 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:06:40 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,63,43]] 16:06:40 INFO - process_Request line: dromaeo_css 6852.60 graph.html#tests=[[72,63,43]] 16:06:40 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:06:40 INFO - process_Request line: kraken 1529.50 graph.html#tests=[[232,63,43]] 16:06:40 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:06:40 INFO - process_Request line: v8_7 21233.85 graph.html#tests=[[230,63,43]] 16:06:40 INFO - RETURN: dromaeo_css: 6852.60 16:06:40 INFO - RETURN: kraken: 1529.50 16:06:40 INFO - RETURN: v8_7: 21233.85 16:06:40 INFO - javascript benchmark 16:06:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3144.449721298773, 3188.569543111679, 3226.709596136347, 3240.497722852957, 3242.432574299497, 5257.973710131444, 5375.48932851379, 5386.622936394449, 5402.0, 5407.134858422653, 5324.174752913295, 5333.0, 5385.192221166817, 5407.188921661753, 5433.891322173564, 4627.699199552018, 4884.218525035995, 5046.52058054486, 5057.0897238497055, 5075.340205773245, 4809.446913604946, 4951.257311403282, 5004.224345226496, 5015.648904576681, 5053.696778193302, 4861.124997500448, 4863.319135321076, 4936.136176169192, 4981.227909674007, 4986.4764199758865, 4806.375171227753, 4809.132293288633, 4826.420829500483, 4839.951600483985, 4864.878378040542, 4763.785629646674, 4821.252705830602, 4829.420469543642, 4835.153848076572, 4844.612431005511, 5196.53231209193, 5212.582993360522, 5226.764795584169, 5237.973810130925, 5254.605904557174, 5780.3063632363965, 5787.623804452697, 5789.247397838254, 5790.04464263396, 5805.535557155417, 5663.377028526858, 5765.769369225226, 5820.243368362128, 5821.912671309934, 5860.736266868002, 5325.121354976385, 5335.0, 5338.679679219259, 5364.409914909357, 5371.623986320959, 5842.912356314659, 5843.853903652443, 5851.824445266649, 5854.765809367663, 5869.735861886225, 5547.611667183259, 5597.188407680864, 5631.493165615032, 5695.031844586348, 5706.001449746278, 5852.0, 5862.472377486047, 5871.119332100219, 5893.734781934823, 5897.174395584621, 5799.536037117021, 5849.532037436995, 5856.355800861902, 5865.149553314745, 5868.911966320508, 5564.054110801174, 5656.066748986371, 5736.569757268222, 5863.882722345615, 5864.648121112747, 4473.5526447355005, 4481.395011673448, 4505.144022635689, 4509.030558429953, 4511.345854851028, 3958.5447673517915, 3998.420229066769, 4017.276890159741, 4044.838206471708, 4045.9797701011307, 5268.9736551317, 5377.704226267515, 5395.81114660985, 5514.531264842453, 5535.308086489189, 5811.82564523065, 5889.764409423575, 5897.64614123154, 5915.911261331084, 5920.2895652521975, 5240.423553409122, 5476.835694929079, 5488.9725551372785, 5495.945040549544, 5498.285222921075, 4867.221244600847, 4894.363732714795, 4957.405111386584, 4959.330490383752, 5003.049420610072, 5985.0, 6046.395360463918, 6059.0608455689435, 6060.666663333559, 6074.3925607438905, 5581.10702287632, 5653.067243904709, 5775.33583637887, 5829.562782791223, 5832.300123984979, 6036.7283472244735, 6124.869201255597, 6129.603311142587, 6135.680249343183, 6142.802153580009, 5804.390538993345, 5828.912566311424, 5855.765769369177, 5867.794627188198, 5885.0, 5642.492175704207, 5752.597318187687, 5795.8551036224435, 5925.851853703692, 5948.643081415129, 5540.113581826889, 5554.361248456479, 5568.777248909998, 5580.414056524169, 5608.270924779753, 5570.0, 5570.5543556516195, 5575.498205161555, 5584.46947539983, 5588.636738611977, 5459.699716515471, 5503.724813759376, 5531.695756733418, 5540.972295138659, 5615.0173719599725, 5692.260006199168, 5748.827535173951, 5774.566907481872, 5776.682282474504, 5793.884122317614, 5593.328800543798, 5597.860053498533, 5641.633293835887, 5644.774209031592, 5651.0], "unit": "score", "name": "dojo.html", "value": 5333.730409735117}, {"lowerIsBetter": false, "replicates": [525.9953488836323, 540.3299908113938, 558.7876606889382, 568.9573282003851, 569.35947059558, 35061.0, 35493.2901341973, 35752.2849543009, 35800.82099589505, 35997.99999999997, 39047.43810247587, 39612.0, 39623.207535849266, 39636.20727585454, 39773.60226397735, 8541.316694664427, 8679.132086791333, 8685.696000639979, 8688.739337819876, 8690.391672582922, 8421.873671894926, 8610.741677749646, 8634.784130396727, 8837.248833849131, 8838.29293656506, 8846.955765221164, 8880.978687450928, 8903.95548022259, 8912.108789121101, 8912.688055918044, 8738.519381434018, 8754.343424243143, 8814.294856411536, 8814.779630509225, 8839.558022098901, 8583.18459746323, 8722.476651400873, 8739.563021848882, 8749.737507874774, 8767.473951562863, 39110.41334379987, 39683.40474892879, 39796.80101599474, 39842.601573984466, 39888.60111398907, 2728.741488170169, 2895.2327633177224, 2987.1635941936293, 3084.090193392932, 3180.3321302526497, 26169.345766355993, 26400.86799566009, 26816.59775103375, 26966.865165674244, 27158.728412715816, 3522.6477352264824, 3563.2873425314783, 3603.081214290339, 3676.7793932364143, 3684.0973961379364, 180714.096429517, 181408.0, 182029.0, 182479.99999999866, 182927.99999999866, 40891.59108408937, 49521.50478495241, 54563.727181363836, 54612.18081728777, 54628.0, 39830.0, 39834.800825996266, 39947.40078898819, 40167.1966560673, 40198.79900600478, 13576.93211533936, 13742.587722368346, 13775.724485510234, 13815.102018368974, 13851.653708657364, 11654.76690466186, 11783.234089784137, 11795.52817887292, 11797.88202117968, 11800.704982375337, 13957.302134893214, 14045.087069340665, 14456.204908729911, 14499.492517761828, 14538.781918271234, 5778.295402856167, 5835.387284335168, 5857.912131318034, 5877.9118313225335, 5959.433853783884, 923.8845144356956, 961.7355227312405, 1068.8663917010374, 1112.8386383974278, 1130.2370899642708, 30666.0, 32315.838420807744, 33950.320993580484, 34129.0, 34339.82830085883, 968.8982656821073, 976.8827740671165, 1004.8191325561469, 1030.5362586835954, 1168.2756690851556, 14422.134671919508, 14742.852571474363, 14769.704605908037, 14834.0, 14837.62905927339, 749745.0, 759088.0, 767194.0, 769800.0, 773303.0, 55128.0, 55265.0, 55522.44477555253, 55632.16551751727, 55681.44318556762, 1312.9803052954214, 1390.0686540018212, 1390.6245313765228, 1397.573740009307, 1401.3203596255807, 28488.430231395672, 29960.550591740706, 30092.849535752182, 30105.698943011164, 30318.696813031587, 46123.53876461193, 46205.30692039689, 46321.0, 46531.302030470244, 46559.30161047655, 232405.0, 233350.0, 233768.0, 234012.0, 234736.0, 31984.68015319817, 42924.57075429206, 42942.57057429386, 44128.0, 44132.33801492916, 41723.7913810429, 42535.149297014505, 42862.35706464468, 43031.0, 43621.0, 36081.639183607826, 36132.09669758172, 36325.818370907975, 36953.07617309589, 37333.6266637341, 36010.77898098666, 36264.81867590751, 36294.0, 36401.817990909876, 36584.0, 34657.826710866284, 35741.0, 35947.10132246715, 36034.819825900704, 36039.63960360468, 30205.0, 33131.50302745413, 33546.49680254847, 33609.327813444084, 33642.3271534563, 25102.24693259205, 25109.372265693502, 25350.619740704275, 25467.73081879076, 25620.8718956404], "unit": "score", "name": "ext.html", "value": 18002.36474609398}, {"lowerIsBetter": false, "replicates": [369.06258104414786, 369.3665363900909, 369.51039872169383, 370.4887255587289, 374.65906025516784, 16469.75295370569, 17378.65242695147, 17440.127993600334, 18010.72983905241, 18148.546286342847, 11120.721981950435, 11577.942110289438, 13221.20672759635, 13224.735505289913, 13260.1380910241, 4855.490173531773, 4910.8281210157475, 5039.974800126012, 5053.949460505403, 5057.41839688435, 5036.043151801146, 5042.873928151789, 5057.822976195834, 5058.645894787366, 5063.898722025558, 3599.1002249437643, 3705.0366904604725, 5006.824761133361, 5013.674111182761, 5019.6988180709095, 5383.596230282725, 5564.33228012641, 5568.972155139199, 5569.415211402805, 5578.163275508666, 5254.474552544753, 5339.305890234284, 5339.5728341732565, 5347.812826551091, 5361.678299302054, 19740.0, 19743.0, 20085.39743807688, 20321.695174572393, 20426.79573204264, 1956.5695546979641, 1989.8109679580416, 2086.1863873089505, 2163.5132095278595, 2263.7509873913855, 12835.229886206858, 13166.414208916218, 13275.933620331933, 13308.534201303004, 13327.533536326182, 1776.085316062229, 1789.818719645028, 1802.8557715382738, 1815.1831675745966, 1834.6514162309118, 53380.0, 54808.451915480735, 57878.42121578773, 59072.40927590712, 59161.408385916024, 9946.35348702332, 10267.0, 10353.74115647115, 10356.119729823049, 10398.272120951611, 13402.463901443833, 13461.326933653474, 13475.0, 13478.0, 13502.257375844227, 7267.345938865527, 7379.262073792685, 7403.8149046274275, 7423.962880185564, 7498.887516687254, 7002.299770022957, 7009.7897063088185, 7026.718931242795, 7039.753608623673, 7085.43316534676, 4404.185225733249, 4496.168208881302, 4504.1087136680935, 4507.549245075466, 4513.300438432048, 1834.559705670656, 1865.4217192670317, 1894.687376582876, 1902.876313039648, 1912.0726447672866, 448.2894612039888, 457.69334545854355, 947.8957314695378, 997.9950100249453, 1048.9423081730579, 10732.946335268274, 10977.890221097687, 11118.221724479208, 11186.32882027081, 11266.211365204357, 458.47046661106475, 463.1709240459607, 465.2137886971008, 469.4319872953696, 472.27270004193844, 5862.912056319158, 6044.335123136451, 6086.726097325631, 6089.117078023751, 6151.5386346024225, 508123.0, 522897.0, 525629.0, 528755.0, 585752.0, 78977.60511197407, 79677.60161199157, 81060.59469702732, 81132.0, 82306.58846705848, 486.642317896353, 492.0503428383255, 492.50257240186954, 493.57799081784555, 495.25958691756773, 9774.169195618168, 10063.245256605638, 10157.9492102539, 10175.7456063599, 10266.332688375232, 31794.364112717154, 32012.67987320097, 32056.198595035312, 32493.0, 32823.50764738483, 44207.77896110499, 45569.0, 45615.54384456113, 45750.54249457463, 46575.301370478795, 8951.507667078373, 9627.085426884434, 9733.221342292458, 9733.270004749531, 9823.557939892578, 16284.592885177492, 17218.65562688764, 17454.127293635014, 17492.300307987538, 17517.386891458736, 14003.579892603238, 14489.058211216237, 14521.346539405964, 14647.487337943121, 14829.851701483278, 12869.871301287241, 13858.4456621734, 14096.929515352767, 14123.152610843383, 14578.125312481285, 14509.419623215375, 14768.187749673441, 14783.113231407116, 14882.553523394316, 15087.396504139711, 9519.714408567754, 9586.089321514444, 9869.457179855177, 9884.30809843304, 9902.900970990198, 14772.55682329532, 14840.0, 14975.775363369776, 15018.324175411914, 15153.621159471102], "unit": "score", "name": "jquery.html", "value": 8100.54133435804}, {"lowerIsBetter": false, "replicates": [1475.970480590388, 1494.0960718765148, 1661.169415292353, 1807.2138619700422, 1825.1072050799482, 7399.630018499074, 7477.813054673636, 7572.432067594938, 7638.618069096544, 7648.770536883895, 7145.392641625468, 7149.249328820477, 7200.315969982843, 7206.639668016604, 7212.927870721304, 2235.16181431963, 2269.1944359752297, 2269.693591365169, 2281.669157972093, 2282.897269622871, 2280.1905323610044, 2280.2247235939776, 2357.0, 2361.1027809432476, 2363.822713296501, 2259.1302348595827, 2270.693456383384, 2289.9656505152434, 2303.49323148907, 2314.0281081945623, 2260.400993736661, 2275.226423016174, 2304.5275718477674, 2312.317866229458, 2326.47654277787, 2283.6917016202765, 2339.7075365579303, 2341.0635745701684, 2346.9061237550477, 2354.0348457132495, 7033.718651253944, 7086.610236436994, 7099.964500177518, 7108.502404831664, 7115.1461824580865, 4582.702124361906, 4703.318018887277, 4707.223308154151, 4717.882052948669, 4730.62155027597, 3040.9847950760327, 3068.8772449102235, 3162.810231386124, 3163.0510846746115, 3164.5727826743555, 963.4604621411962, 988.4662282367512, 1002.8144793213206, 1010.2221289606962, 1037.678319720889, 10179.643712470102, 10250.7437314067, 10312.896871031344, 10346.637867674595, 10370.585176592927, 4120.402541631506, 4197.643200327945, 4204.285271503852, 4263.360495925636, 4269.786510674454, 8454.746357609281, 8526.190011948855, 8535.743927682179, 8543.615537300711, 8550.871736923827, 4608.663487588562, 4667.533246675305, 4669.34629151919, 4689.60138388234, 4690.835820746258, 4280.379344994958, 4282.443282373271, 4293.355996600535, 4296.269634162138, 4319.352097185384, 3356.295178012596, 3380.678835510623, 3403.7957722536726, 3408.6932176103774, 3412.6416726243388, 1110.8278216876397, 1116.2465335898237, 1116.436199719153, 1120.383788916093, 1121.058311018748, 999.3953658036928, 1000.6747806962766, 1086.5708045322053, 1088.374184843718, 1233.8272641830151, 6937.89593156093, 6951.548149370275, 6971.093757811452, 6975.232724400312, 6997.545159564714, 1091.9945400272948, 1092.1153865369076, 1120.260627985542, 1130.2653275371074, 1136.8124259497256, 5635.520980716603, 5724.112762521816, 5732.054211055212, 5737.655740655574, 5738.311402631711, 8745.693900713444, 9113.544322783835, 9170.633174673072, 9176.128267814547, 9252.90747092534, 9012.459252444874, 9044.231240344512, 9093.40892841963, 9136.725898223063, 9138.54307284633, 6830.077939478207, 6911.308869113149, 6934.826629334307, 6975.895361569581, 6982.61595612236, 6433.163688720437, 6455.096286519797, 6461.709223085067, 6493.448056915215, 6495.350464953467, 7761.379089672925, 7884.921150788418, 7915.604219789103, 7960.800979975547, 7974.481658692166, 7969.880451793344, 8108.189181081844, 8130.67477300925, 8135.67457301725, 8230.300424463987, 6274.121622972696, 6350.301466838737, 6506.512011599054, 6650.767223147167, 6658.334166583303, 7150.249223831423, 7188.8921666174, 7197.964010179916, 7202.96398518004, 7214.242504537158, 6136.386361363828, 6657.633830139195, 6823.624700641512, 6875.140607424072, 6930.549514281757, 6551.574147680385, 6572.507061970467, 6659.334066593302, 6800.693968771318, 6954.582725036514, 6819.488538359742, 6900.758473453405, 6910.412614927787, 6911.274316196727, 6945.861082778417, 6404.903926441014, 6409.583377080475, 6414.679266036586, 6419.037144428186, 6419.679016049272, 5959.135925290895, 6031.5476339273855, 6259.311475737756, 6274.749010039547, 6336.968315158395], "unit": "score", "name": "mootools.html", "value": 4365.450372170339}, {"lowerIsBetter": false, "replicates": [343.0754117652926, 353.330438818439, 357.90873327301534, 364.5570631682507, 368.3590552438754, 6110.725017374218, 6171.074338849175, 6197.3492783257725, 6229.096780966757, 6269.905951410721, 6160.722767475463, 6191.442770150686, 6194.504439644829, 6220.9377906220925, 6228.346023667517, 4743.573078422941, 4761.000189960113, 4771.689840160396, 4777.80888764449, 4777.972735861789, 4742.478327383985, 4780.330753694486, 4782.736949467778, 4789.976050119762, 4799.808007679689, 4568.360429539867, 4621.145088158702, 4666.113438446701, 4669.392978912737, 4702.130105930397, 4658.254679251338, 4680.648951328664, 4684.0397718467975, 4689.742064186468, 4691.812327506896, 4088.8160032798296, 4100.220958017997, 4112.650424713903, 4113.053997580543, 4128.876133715993, 5852.502537284294, 5884.941150588482, 5885.8822823543715, 5889.087191485327, 5894.410558944114, 5309.0, 5440.863978400532, 5466.972665136688, 5470.8085217017215, 5483.670979741229, 6509.41415272623, 6520.413162815369, 6530.412262896362, 6534.901976470357, 6547.705353259114, 4535.727856328631, 4535.9546404536195, 4537.77311134442, 4539.070894869667, 4544.18204723153, 6759.93240067598, 6789.864202715918, 6821.317868213188, 6823.249442561314, 6868.347506986828, 4673.439187297546, 4697.412823397075, 4722.952770472251, 4725.432948046187, 4727.338172655831, 4718.4809670936165, 4738.881527961828, 4742.454617718938, 4744.051189761993, 4749.026449577828, 5464.9453505464435, 5467.343918729698, 5470.835874923759, 5475.288212532425, 5487.807926722546, 6442.48460123189, 6579.539432239697, 6586.473082153416, 6607.405333520006, 6610.933890661032, 1663.076992269278, 1687.215444818141, 1688.7382455719383, 1691.1375198648777, 1691.4249155287016, 1101.9779604407868, 1123.27548731068, 1127.808272593661, 1138.0781566930812, 1146.7878442488166, 6229.3770622937345, 6241.656708881055, 6247.406496382836, 6247.781327653511, 6257.499400047986, 6721.7311307548125, 6751.426128779109, 6773.72905083801, 6778.627175505395, 6782.762603308861, 6189.288231853305, 6206.162168107338, 6236.220472440945, 6308.463780578702, 6320.241571011508, 3710.6289371062676, 3722.6277372262557, 3737.3272810893754, 3738.12154143776, 3739.9252014959548, 7197.928020719831, 7204.783856484314, 7208.783736487913, 7215.783526494213, 7217.963910180415, 6919.792406227822, 6987.790366289019, 7023.89464158038, 7027.297270272932, 7060.505764596429, 7066.646667666596, 7177.210506844243, 7182.820429489305, 7197.4961752677855, 7215.278472152742, 6857.5199736018, 6859.108315918898, 6866.176058872968, 6866.588004719732, 6884.586924784529, 6719.764808231688, 6733.293004234485, 6814.965925170342, 6822.829429264109, 6822.965885170543, 7184.209736929038, 7196.712131514681, 7203.495755297288, 7207.13514378278, 7219.45854060937, 4641.164590373765, 4663.976680116578, 4702.741349225826, 4708.576228139484, 4709.317149013443, 6694.4644428444635, 6813.3527314905, 6848.178218613599, 6848.486363522856, 6882.208546017272, 6629.105070815378, 6639.302873198245, 6654.500912431684, 6671.132752742113, 6681.432078273401, 6641.435477984425, 6654.667266636552, 6668.933310666831, 6677.065210870385, 6680.231773346128, 6246.344133865879, 6463.515236357386, 6488.805335839932, 6543.869122617616, 6547.0, 6691.0, 6697.899531506934, 6707.128073350434, 6725.730970761115, 6731.158605174353, 6341.334159913143, 6503.382178693017, 6517.902231466626, 6553.868922621426, 6553.934460655523], "unit": "score", "name": "prototype.html", "value": 4985.630239539809}, {"lowerIsBetter": false, "replicates": [644.5037321262627, 649.3733547127022, 660.8744338575672, 791.540906274361, 819.4264015189373, 13005.414756335964, 13284.734305313888, 13307.733845323088, 15404.306806193721, 15727.0, 14703.705925881475, 14739.778903316432, 14843.109413435175, 14876.330565124568, 14884.553463396116, 825.4015838517087, 830.6760363458257, 842.5829214538812, 846.7417437681505, 852.86780549015, 836.4145098431122, 838.4089217101958, 841.4993079117914, 842.9325653947669, 846.5301757524571, 872.6640243506264, 879.9956000220022, 880.6917578847416, 882.1883866842488, 883.3419102768446, 870.7648934787603, 877.1973644115626, 879.8064425826308, 880.0495464897926, 881.0660699658318, 649.9772507962246, 650.6356440393395, 654.0940796996147, 654.1986067067851, 655.3348351423309, 13719.794203086962, 13804.585862424143, 13826.93086534571, 13835.861641383659, 13845.584632461043, 10917.890821091767, 11967.461464234131, 12019.57931472403, 12147.696307592292, 12417.75164496714, 9406.153446189875, 9423.858642120374, 9445.149936505679, 9484.478353690612, 10015.266870890186, 3533.6819686228105, 3566.732495062881, 3573.3746594345885, 3581.6418358164237, 3587.4798154267487, 46555.30167047463, 46863.765681171375, 47253.76373118113, 47697.0, 48099.51900480985, 9553.713388598353, 9571.473568953636, 9772.21822254218, 9805.80388392228, 9887.950560247296, 17906.0, 17920.193591288422, 17932.193051312723, 17956.55108622295, 17963.640727185382, 6932.861342773116, 7154.749583764543, 7173.820654483679, 7191.316824901626, 7298.52559583636, 4188.727732697365, 4204.3903633972905, 4339.153864996359, 4355.60799528044, 4367.235733746582, 3060.73983711387, 3082.6300843898875, 3096.1949893027527, 3098.798578092417, 3099.9070027899197, 564.3650892745661, 569.7521578113534, 575.23493753308, 575.4073304496376, 576.1099101887594, 468.20639016866767, 470.097412967104, 473.37987236720005, 478.4497827498405, 489.2783144861372, 7914.604269786603, 8008.0, 8110.553919534483, 8262.876056859152, 8267.545285009262, 488.8973315603763, 492.2067268252652, 559.1696330948538, 652.7356420649644, 667.5060455263167, 3580.7135429165605, 3866.3040652682225, 4196.0, 4213.389058586487, 4308.870733877989, 54876.0, 55227.44772552223, 55308.72345638327, 55573.16640250399, 57055.0, 48657.0, 48960.51039489631, 49286.0, 49803.25295120576, 50265.0, 40224.396634050514, 40445.59554404477, 40811.18377632431, 41006.104420080046, 41020.1795964085, 8342.499450033018, 8675.956620216859, 8739.0390032933, 8888.066752990842, 8993.460392376479, 34787.9563613092, 34953.300933981685, 35441.82279088588, 35870.46194307035, 35895.28209435744, 42884.57115428806, 43415.56584434115, 43762.0, 44161.0, 44636.0, 10736.731581710208, 10856.0, 11097.0, 11208.439578021229, 11306.095512359156, 11433.942830285796, 11485.885141148816, 11615.883841161818, 11749.177557571229, 12135.150539462153, 9686.370385924893, 9854.802903941738, 9961.053699898497, 10384.844227336747, 10445.843312350169, 9740.366876153028, 10015.39907605546, 10051.899481005388, 10209.081182693297, 10455.16358691318, 10254.846177307198, 10369.585216591251, 10492.265541412027, 10919.235653504178, 11008.669739907815, 9048.366614336934, 9251.121143491358, 9271.67549135777, 9282.164605185566, 9693.079157480028, 8384.874226886725, 8537.871931920901, 8669.0, 9048.638054477748, 9213.953930230306], "unit": "score", "name": "yui.html", "value": 6116.046919420991}], "name": "dromaeo_css", "value": 6852.596824901459}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 107.0, 112.0, 112.0, 112.0, 122.0, 111.0, 111.0, 113.0, 112.0], "unit": "score", "name": "ai-astar", "value": 112.5}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 161.0, 173.0, 134.0, 152.0, 153.0, 129.0, 178.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 149.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 162.0, 165.0, 161.0, 165.0, 173.0, 167.0, 162.0], "unit": "score", "name": "audio-dft", "value": 164.2}, {"lowerIsBetter": true, "replicates": [75.0, 76.0, 75.0, 76.0, 72.0, 73.0, 76.0, 137.0, 75.0, 71.0], "unit": "score", "name": "audio-fft", "value": 80.6}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 141.0, 95.0, 97.0, 97.0, 139.0, 96.0, 96.0, 146.0], "unit": "score", "name": "audio-oscillator", "value": 110.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 148.0, 147.0, 148.0, 147.0, 148.0, 147.0, 151.0], "unit": "score", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [61.0, 59.0, 59.0, 60.0, 60.0, 62.0, 60.0, 59.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 70.0, 68.0, 69.0, 70.0, 69.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [93.0, 87.0, 85.0, 88.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.9}, {"lowerIsBetter": true, "replicates": [125.0, 122.0, 118.0, 135.0, 129.0, 122.0, 126.0, 123.0, 127.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.6}, {"lowerIsBetter": true, "replicates": [141.0, 154.0, 145.0, 152.0, 151.0, 142.0, 152.0, 149.0, 160.0, 146.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.2}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 70.0, 73.0, 69.0, 69.0, 68.0, 68.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.7}], "name": "kraken", "value": 1529.5000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.16816218012627], "unit": "score", "name": "Richards", "value": 212.4474360000001}, {"lowerIsBetter": false, "replicates": [188.96447467876038], "unit": "score", "name": "DeltaBlue", "value": 349.896456}, {"lowerIsBetter": false, "replicates": [280.2690582959641], "unit": "score", "name": "Encrypt", "value": 949.7338080000005}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1072.961373390558], "unit": "score", "name": "RayTrace", "value": 689.6697479999999}, {"lowerIsBetter": false, "replicates": [718.9072609633357], "unit": "score", "name": "Earley", "value": 927.0500329999999}, {"lowerIsBetter": false, "replicates": [12207.317073170732], "unit": "score", "name": "Boyer", "value": 54.595370629370635}, {"lowerIsBetter": false, "replicates": [26179.48717948718], "unit": "score", "name": "RegExp", "value": 34.79766405484819}, {"lowerIsBetter": false, "replicates": [609.0133982947625], "unit": "score", "name": "Splay", "value": 133.80822200000003}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 21233.853239677315}]} 16:06:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,63,43]]", "result": "21233.85"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,63,43]]", "result": "1529.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,63,43]]", "result": "6852.60"}}} 16:06:40 INFO - Return code: 0 16:06:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 16:06:40 INFO - # TBPL SUCCESS # 16:06:40 INFO - Running post-action listener: _resource_record_post_action 16:06:40 INFO - Running post-run listener: _resource_record_post_run 16:06:41 INFO - Total resource usage - Wall time: 1228s; CPU: 13.0%; Read bytes: 4096; Write bytes: 557678592; Read time: 8; Write time: 430440 16:06:41 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 237088768; Read time: 0; Write time: 228800 16:06:41 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319725568; Read time: 8; Write time: 201592 16:06:41 INFO - Running post-run listener: _upload_blobber_files 16:06:41 INFO - Blob upload gear active. 16:06:41 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 16:06:41 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:06:41 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 16:06:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 16:06:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:06:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:06:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:06:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:06:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:06:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:06:43 INFO - (blobuploader) - INFO - Done attempting. 16:06:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:06:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:06:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:06:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:06:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:06:43 INFO - (blobuploader) - INFO - Done attempting. 16:06:43 INFO - (blobuploader) - INFO - Iteration through files over. 16:06:43 INFO - Return code: 0 16:06:43 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 16:06:43 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 16:06:43 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20485c81aaef56dbec9362c8b4acf0aeef4e800b3647e195b6158dd99598ab8da2305ebf841af427eaf081d0121f280fe397f6018e535330a499c50b2ddb8b6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21c724defe6a376d7942d91b67f822b280312a6cabdd4642a60287191935352ab9fdbbc5eff0e4cf8a5d371ee9f8385772a6a4a9133ac7a524cd514f3a2f284c"} 16:06:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 16:06:43 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 16:06:43 INFO - Contents: 16:06:43 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20485c81aaef56dbec9362c8b4acf0aeef4e800b3647e195b6158dd99598ab8da2305ebf841af427eaf081d0121f280fe397f6018e535330a499c50b2ddb8b6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21c724defe6a376d7942d91b67f822b280312a6cabdd4642a60287191935352ab9fdbbc5eff0e4cf8a5d371ee9f8385772a6a4a9133ac7a524cd514f3a2f284c"} 16:06:43 INFO - Copying logs to upload dir... 16:06:43 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1275.323805 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2015-12-31 16:06:43.484015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 16:06:43.491490) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test-pgo/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20485c81aaef56dbec9362c8b4acf0aeef4e800b3647e195b6158dd99598ab8da2305ebf841af427eaf081d0121f280fe397f6018e535330a499c50b2ddb8b6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21c724defe6a376d7942d91b67f822b280312a6cabdd4642a60287191935352ab9fdbbc5eff0e4cf8a5d371ee9f8385772a6a4a9133ac7a524cd514f3a2f284c"} build_url:https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011297 build_url: 'https://queue.taskcluster.net/v1/task/dbUNML_RRrejrwZdExx50g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/20485c81aaef56dbec9362c8b4acf0aeef4e800b3647e195b6158dd99598ab8da2305ebf841af427eaf081d0121f280fe397f6018e535330a499c50b2ddb8b6b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/21c724defe6a376d7942d91b67f822b280312a6cabdd4642a60287191935352ab9fdbbc5eff0e4cf8a5d371ee9f8385772a6a4a9133ac7a524cd514f3a2f284c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2015-12-31 16:06:43.519799) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 16:06:43.520159) ========= rm -f oauth.txt in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1451604310.394115-1197856158 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004486 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-31 16:06:43.606047) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 16:06:43.606441) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-31 16:06:43.606781) ========= ========= Total master_lag: 0.30 =========