builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-001 starttime: 1451890902.35 results: success (0) buildid: 20160103203025 builduid: 8972b80662f84495bd182bfe3debb325 revision: 66b4c1052117aa21d74980b9c9978835da56b905 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.351513) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.352256) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.352696) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.004312 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.370924) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.371324) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.383704) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.384116) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004611 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.436891) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.437595) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.438474) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.439004) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-03 23:01:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 33.1M=0s 2016-01-03 23:01:42 (33.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.158320 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.611601) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.612221) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015228 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.664901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:42.665490) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 66b4c1052117aa21d74980b9c9978835da56b905 --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/b2g-inbound --rev 66b4c1052117aa21d74980b9c9978835da56b905 --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=b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-03 23:01:42,904 truncating revision to first 12 chars 2016-01-03 23:01:42,904 Setting DEBUG logging. 2016-01-03 23:01:42,904 attempt 1/10 2016-01-03 23:01:42,904 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/66b4c1052117?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-03 23:01:43,154 unpacking tar archive at: b2g-inbound-66b4c1052117/testing/mozharness/ program finished with exit code 0 elapsedTime=0.571029 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:43.252034) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:43.252435) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:43.433963) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:43.434444) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-03 23:01:43.435071) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-03 23:01:43.435505) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-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', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-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=b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:01:43 INFO - MultiFileLogger online at 20160103 23:01:43 in /builds/slave/test-pgo 23:01:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 23:01:43 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 23:01:43 INFO - {'append_to_log': False, 23:01:43 INFO - 'base_work_dir': '/builds/slave/test-pgo', 23:01:43 INFO - 'blob_upload_branch': 'B2G-Inbound', 23:01:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 23:01:43 INFO - 'branch': 'B2G-Inbound', 23:01:43 INFO - 'buildbot_json_path': 'buildprops.json', 23:01:43 INFO - 'config_files': ('talos/linux_config.py',), 23:01:43 INFO - 'default_actions': ('clobber', 23:01:43 INFO - 'read-buildbot-config', 23:01:43 INFO - 'download-and-extract', 23:01:43 INFO - 'populate-webroot', 23:01:43 INFO - 'create-virtualenv', 23:01:43 INFO - 'install', 23:01:43 INFO - 'run-tests'), 23:01:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:01:43 INFO - 'download_minidump_stackwalk': True, 23:01:43 INFO - 'download_symbols': 'ondemand', 23:01:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:01:43 INFO - 'tooltool.py': '/tools/tooltool.py', 23:01:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:01:43 INFO - '/tools/misc-python/virtualenv.py')}, 23:01:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:01:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:01:43 INFO - 'installer_path': 'installer.exe', 23:01:43 INFO - 'log_level': 'info', 23:01:43 INFO - 'log_name': 'talos', 23:01:43 INFO - 'log_to_console': True, 23:01:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:01:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:01:43 INFO - 'opt_config_files': (), 23:01:43 INFO - 'pip_index': False, 23:01:43 INFO - 'sps_profile': False, 23:01:43 INFO - 'sps_profile_interval': 0, 23:01:43 INFO - 'suite': 'dromaeojs', 23:01:43 INFO - 'system_bits': '32', 23:01:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:01:43 INFO - 'title': 'talos-linux64-ix-001', 23:01:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:01:43 INFO - 'use_talos_json': True, 23:01:43 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 23:01:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:01:43 INFO - 'work_dir': 'build'} 23:01:43 INFO - ##### 23:01:43 INFO - ##### Running clobber step. 23:01:43 INFO - ##### 23:01:43 INFO - Running pre-action listener: _resource_record_pre_action 23:01:43 INFO - Running main action method: clobber 23:01:43 INFO - rmtree: /builds/slave/test-pgo/build 23:01:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 23:01:44 INFO - Running post-action listener: _resource_record_post_action 23:01:44 INFO - ##### 23:01:44 INFO - ##### Running read-buildbot-config step. 23:01:44 INFO - ##### 23:01:44 INFO - Running pre-action listener: _resource_record_pre_action 23:01:44 INFO - Running main action method: read_buildbot_config 23:01:44 INFO - Using buildbot properties: 23:01:44 INFO - { 23:01:44 INFO - "project": "", 23:01:44 INFO - "product": "firefox", 23:01:44 INFO - "script_repo_revision": "production", 23:01:44 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 23:01:44 INFO - "repository": "", 23:01:44 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 23:01:44 INFO - "buildid": "20160103203025", 23:01:44 INFO - "pgo_build": "True", 23:01:44 INFO - "basedir": "/builds/slave/test-pgo", 23:01:44 INFO - "buildnumber": 1085, 23:01:44 INFO - "slavename": "talos-linux64-ix-001", 23:01:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:01:44 INFO - "platform": "ubuntu64_hw", 23:01:44 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 23:01:44 INFO - "branch": "b2g-inbound", 23:01:44 INFO - "repo_path": "integration/b2g-inbound", 23:01:44 INFO - "revision": "66b4c1052117aa21d74980b9c9978835da56b905", 23:01:44 INFO - "stage_platform": "linux64-pgo", 23:01:44 INFO - "builduid": "8972b80662f84495bd182bfe3debb325", 23:01:44 INFO - "slavebuilddir": "test" 23:01:44 INFO - } 23:01:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 23:01:44 INFO - Running post-action listener: _resource_record_post_action 23:01:44 INFO - ##### 23:01:44 INFO - ##### Running download-and-extract step. 23:01:44 INFO - ##### 23:01:44 INFO - Running pre-action listener: _resource_record_pre_action 23:01:44 INFO - Running main action method: download_and_extract 23:01:44 INFO - mkdir: /builds/slave/test-pgo/build/tests 23:01:44 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')]} 23:01:44 INFO - https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 23:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/test_packages.json 23:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/test_packages.json 23:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 23:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 23:01:44 INFO - Downloaded 1302 bytes. 23:01:44 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 23:01:44 INFO - Using the following test package requirements: 23:01:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:01:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:01:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:01:44 INFO - u'jsshell-linux-x86_64.zip'], 23:01:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:01:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:01:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:01:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:01:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:01:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 23:01:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 23:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:01:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:01:44 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')]} 23:01:44 INFO - https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/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 23:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/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 23:01:45 INFO - Downloaded 23197869 bytes. 23:01:45 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 23:01:45 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:01:45 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 23:01:47 INFO - Return code: 0 23:01:47 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 23:01: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')]} 23:01:47 INFO - https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:01:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:01:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:01:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/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 23:01:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/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 23:01:48 INFO - Downloaded 23197869 bytes. 23:01:48 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 23:01:48 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 23:01:48 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 23:01:49 INFO - Return code: 0 23:01:49 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')]} 23:01:49 INFO - https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:01:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:01:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:01:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/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 23:01:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/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 23:01:50 INFO - Downloaded 11132285 bytes. 23:01:50 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 23:01:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 23:01:50 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 23:01:50 INFO - Return code: 0 23:01:50 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')]} 23:01:50 INFO - https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/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 23:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LlwiUCfFSSCx0hcXMA75Vg/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 23:01:51 INFO - Downloaded 54987550 bytes. 23:01:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:01:51 INFO - mkdir: /builds/slave/test-pgo/properties 23:01:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 23:01:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 23:01:51 INFO - Contents: 23:01:51 INFO - build_url:https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 23:01:51 INFO - Running post-action listener: _resource_record_post_action 23:01:51 INFO - Running post-action listener: set_extra_try_arguments 23:01:51 INFO - ##### 23:01:51 INFO - ##### Running populate-webroot step. 23:01:51 INFO - ##### 23:01:51 INFO - Running pre-action listener: _resource_record_pre_action 23:01:51 INFO - Running main action method: populate_webroot 23:01:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:01:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:01:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:01:51 INFO - '--tppagecycles', 23:01:51 INFO - '7'], 23:01:51 INFO - 'tests': ['tsvgm']}}, 23:01:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 23:01:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 23:01:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:01:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:01:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 23:01:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 23:01:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:01:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:51 INFO - 'talos_options': ['--e10s'], 23:01:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:01:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:51 INFO - 'tests': ['damp', 'tps']}, 23:01:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:51 INFO - 'talos_options': ['--e10s'], 23:01:51 INFO - 'tests': ['damp', 'tps']}, 23:01:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 23:01:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:01:51 INFO - 'other': {'tests': ['a11yr', 23:01:51 INFO - 'ts_paint', 23:01:51 INFO - 'tpaint', 23:01:51 INFO - 'sessionrestore', 23:01:51 INFO - 'sessionrestore_no_auto_restore']}, 23:01:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 23:01:51 INFO - 'tests': ['a11yr', 23:01:51 INFO - 'ts_paint', 23:01:51 INFO - 'tpaint', 23:01:51 INFO - 'sessionrestore', 23:01:51 INFO - 'sessionrestore_no_auto_restore']}, 23:01:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 23:01:51 INFO - 'tests': ['a11yr', 23:01:51 INFO - 'ts_paint', 23:01:51 INFO - 'tpaint', 23:01:51 INFO - 'sessionrestore', 23:01:51 INFO - 'sessionrestore_no_auto_restore']}, 23:01:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 23:01:51 INFO - 'tests': ['a11yr', 23:01:51 INFO - 'ts_paint', 23:01:51 INFO - 'tpaint', 23:01:51 INFO - 'sessionrestore', 23:01:51 INFO - 'sessionrestore_no_auto_restore']}, 23:01:51 INFO - 'other_l64': {'tests': ['a11yr', 23:01:51 INFO - 'ts_paint', 23:01:51 INFO - 'tpaint', 23:01:51 INFO - 'sessionrestore', 23:01:51 INFO - 'sessionrestore_no_auto_restore']}, 23:01:51 INFO - 'other_nol64': {'tests': ['a11yr', 23:01:51 INFO - 'ts_paint', 23:01:51 INFO - 'tpaint', 23:01:51 INFO - 'sessionrestore', 23:01:51 INFO - 'sessionrestore_no_auto_restore']}, 23:01:51 INFO - 'svgr': {'tests': ['tsvgx', 23:01:51 INFO - 'tsvgr_opacity', 23:01:51 INFO - 'tart', 23:01:51 INFO - 'tscrollx', 23:01:51 INFO - 'cart']}, 23:01:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 23:01:51 INFO - 'tests': ['tsvgx', 23:01:51 INFO - 'tsvgr_opacity', 23:01:51 INFO - 'tart', 23:01:51 INFO - 'tscrollx', 23:01:51 INFO - 'cart']}, 23:01:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:51 INFO - 'tests': ['tp5o']}, 23:01:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:51 INFO - 'talos_options': ['--e10s'], 23:01:51 INFO - 'tests': ['tp5o']}, 23:01:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:51 INFO - 'talos_options': ['--xperf_path', 23:01:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:01:51 INFO - 'tests': ['tp5n']}, 23:01:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:01:51 INFO - 'talos_options': ['--e10s', 23:01:51 INFO - '--xperf_path', 23:01:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:01:51 INFO - 'tests': ['tp5n']}}, 23:01:51 INFO - 'talos.zip': {'path': '', 23:01:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:01:51 INFO - Running post-action listener: _resource_record_post_action 23:01:51 INFO - ##### 23:01:51 INFO - ##### Running create-virtualenv step. 23:01:51 INFO - ##### 23:01:51 INFO - Running pre-action listener: _resource_record_pre_action 23:01:51 INFO - Running main action method: create_virtualenv 23:01:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 23:01:51 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 23:01:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 23:01:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:01:51 INFO - Using real prefix '/usr' 23:01:51 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 23:01:52 INFO - Installing distribute.............................................................................................................................................................................................done. 23:01:54 INFO - Installing pip.................done. 23:01:54 INFO - Return code: 0 23:01:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 23:01: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')]} 23:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8165a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', '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 23:01: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', 'pip>=1.5'] in /builds/slave/test-pgo/build 23:01: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 pip>=1.5 23:01:54 INFO - Using env: {'DISPLAY': ':0', 23:01:54 INFO - 'HOME': '/home/cltbld', 23:01:54 INFO - 'LANG': 'en_US.UTF-8', 23:01:54 INFO - 'LANGUAGE': 'en_US:en', 23:01:54 INFO - 'LOGNAME': 'cltbld', 23:01:54 INFO - 'MAIL': '/var/mail/cltbld', 23:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:54 INFO - 'MOZ_NO_REMOTE': '1', 23:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:54 INFO - 'NO_EM_RESTART': '1', 23:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:01:54 INFO - 'PWD': '/builds/slave/test-pgo', 23:01:54 INFO - 'SHELL': '/bin/bash', 23:01:54 INFO - 'SHLVL': '1', 23:01:54 INFO - 'TERM': 'linux', 23:01:54 INFO - 'TMOUT': '86400', 23:01:54 INFO - 'USER': 'cltbld', 23:01:54 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:54 INFO - '_': '/tools/buildbot/bin/python'} 23:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:54 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 23:01:54 INFO - Cleaning up... 23:01:54 INFO - Return code: 0 23:01:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 23:01: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')]} 23:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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', '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 0x7fc8165a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', '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 23:01: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', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 23:01: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 psutil>=0.7.1 23:01:54 INFO - Using env: {'DISPLAY': ':0', 23:01:54 INFO - 'HOME': '/home/cltbld', 23:01:54 INFO - 'LANG': 'en_US.UTF-8', 23:01:54 INFO - 'LANGUAGE': 'en_US:en', 23:01:54 INFO - 'LOGNAME': 'cltbld', 23:01:54 INFO - 'MAIL': '/var/mail/cltbld', 23:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:54 INFO - 'MOZ_NO_REMOTE': '1', 23:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:54 INFO - 'NO_EM_RESTART': '1', 23:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:01:54 INFO - 'PWD': '/builds/slave/test-pgo', 23:01:54 INFO - 'SHELL': '/bin/bash', 23:01:54 INFO - 'SHLVL': '1', 23:01:54 INFO - 'TERM': 'linux', 23:01:54 INFO - 'TMOUT': '86400', 23:01:54 INFO - 'USER': 'cltbld', 23:01:54 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:54 INFO - '_': '/tools/buildbot/bin/python'} 23:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:54 INFO - Downloading/unpacking psutil>=0.7.1 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01:56 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 23:01:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 23:01:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 23:01:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:01:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:01:56 INFO - Installing collected packages: psutil 23:01:56 INFO - Running setup.py install for psutil 23:01:56 INFO - building 'psutil._psutil_linux' extension 23:01:56 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 23:01:56 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 23:01:56 INFO - building 'psutil._psutil_posix' extension 23:01:56 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 23:01:56 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 23:01:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:01:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:01:57 INFO - Successfully installed psutil 23:01:57 INFO - Cleaning up... 23:01:57 INFO - Return code: 0 23:01:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 23:01:57 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')]} 23:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:57 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')]} 23:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:57 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 0x7fc8165a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', '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 23:01:57 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 23:01:57 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 23:01:57 INFO - Using env: {'DISPLAY': ':0', 23:01:57 INFO - 'HOME': '/home/cltbld', 23:01:57 INFO - 'LANG': 'en_US.UTF-8', 23:01:57 INFO - 'LANGUAGE': 'en_US:en', 23:01:57 INFO - 'LOGNAME': 'cltbld', 23:01:57 INFO - 'MAIL': '/var/mail/cltbld', 23:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:57 INFO - 'MOZ_NO_REMOTE': '1', 23:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:57 INFO - 'NO_EM_RESTART': '1', 23:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:01:57 INFO - 'PWD': '/builds/slave/test-pgo', 23:01:57 INFO - 'SHELL': '/bin/bash', 23:01:57 INFO - 'SHLVL': '1', 23:01:57 INFO - 'TERM': 'linux', 23:01:57 INFO - 'TMOUT': '86400', 23:01:57 INFO - 'USER': 'cltbld', 23:01:57 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:57 INFO - '_': '/tools/buildbot/bin/python'} 23:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:01:57 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 23:01:57 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 23:01:57 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 23:01:57 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 23:01:57 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 23:01:57 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 23:01:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:01:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 23:01:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:01:59 INFO - Installing collected packages: mozsystemmonitor 23:01:59 INFO - Running setup.py install for mozsystemmonitor 23:01:59 INFO - Successfully installed mozsystemmonitor 23:01:59 INFO - Cleaning up... 23:01:59 INFO - Return code: 0 23:01:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 23:01: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')]} 23:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:59 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 0x7fc8165a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', '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 23:01:59 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 23:01:59 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 23:01:59 INFO - Using env: {'DISPLAY': ':0', 23:01:59 INFO - 'HOME': '/home/cltbld', 23:01:59 INFO - 'LANG': 'en_US.UTF-8', 23:01:59 INFO - 'LANGUAGE': 'en_US:en', 23:01:59 INFO - 'LOGNAME': 'cltbld', 23:01:59 INFO - 'MAIL': '/var/mail/cltbld', 23:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:59 INFO - 'MOZ_NO_REMOTE': '1', 23:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:59 INFO - 'NO_EM_RESTART': '1', 23:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:01:59 INFO - 'PWD': '/builds/slave/test-pgo', 23:01:59 INFO - 'SHELL': '/bin/bash', 23:01:59 INFO - 'SHLVL': '1', 23:01:59 INFO - 'TERM': 'linux', 23:01:59 INFO - 'TMOUT': '86400', 23:01:59 INFO - 'USER': 'cltbld', 23:01:59 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:59 INFO - '_': '/tools/buildbot/bin/python'} 23:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:59 INFO - Downloading/unpacking blobuploader==1.2.4 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:02:01 INFO - Downloading blobuploader-1.2.4.tar.gz 23:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 23:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:02:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:02:01 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 23:02:01 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 23:02:01 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 23:02:01 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 23:02:01 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 23:02:01 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 23:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 23:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 23:02:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:02:01 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 23:02:01 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 23:02:01 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 23:02:01 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 23:02:01 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 23:02:01 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 23:02:01 INFO - Downloading docopt-0.6.1.tar.gz 23:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 23:02:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 23:02:01 INFO - Installing collected packages: blobuploader, requests, docopt 23:02:01 INFO - Running setup.py install for blobuploader 23:02:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:02:01 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 23:02:01 INFO - Running setup.py install for requests 23:02:02 INFO - Running setup.py install for docopt 23:02:02 INFO - Successfully installed blobuploader requests docopt 23:02:02 INFO - Cleaning up... 23:02:02 INFO - Return code: 0 23:02:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:02:02 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')]} 23:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:02 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')]} 23:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:02 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 0x7fc8165a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', '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 23:02:02 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 23:02:02 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 23:02:02 INFO - Using env: {'DISPLAY': ':0', 23:02:02 INFO - 'HOME': '/home/cltbld', 23:02:02 INFO - 'LANG': 'en_US.UTF-8', 23:02:02 INFO - 'LANGUAGE': 'en_US:en', 23:02:02 INFO - 'LOGNAME': 'cltbld', 23:02:02 INFO - 'MAIL': '/var/mail/cltbld', 23:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:02 INFO - 'MOZ_NO_REMOTE': '1', 23:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:02 INFO - 'NO_EM_RESTART': '1', 23:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:02 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:02 INFO - 'SHELL': '/bin/bash', 23:02:02 INFO - 'SHLVL': '1', 23:02:02 INFO - 'TERM': 'linux', 23:02:02 INFO - 'TMOUT': '86400', 23:02:02 INFO - 'USER': 'cltbld', 23:02:02 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:02 INFO - '_': '/tools/buildbot/bin/python'} 23:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:02:02 INFO - Running setup.py (path:/tmp/pip-tczND4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:02:02 INFO - Running setup.py (path:/tmp/pip-gAwkV3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:02:02 INFO - Running setup.py (path:/tmp/pip-MHkccK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:02:02 INFO - Running setup.py (path:/tmp/pip-GI3KAF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:02:02 INFO - Running setup.py (path:/tmp/pip-aIeP7Z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:02:02 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:02:02 INFO - Running setup.py (path:/tmp/pip-2XAt7o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:02:03 INFO - Running setup.py (path:/tmp/pip-hml7lt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:02:03 INFO - Running setup.py (path:/tmp/pip-INIwg3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:02:03 INFO - Running setup.py (path:/tmp/pip-8RZ5v2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:02:03 INFO - Running setup.py (path:/tmp/pip-Dk8f_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:02:03 INFO - Running setup.py (path:/tmp/pip-f15Do4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:02:03 INFO - Running setup.py (path:/tmp/pip-gAFI3N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:02:03 INFO - Running setup.py (path:/tmp/pip-ohqhA9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:02:03 INFO - Running setup.py (path:/tmp/pip-Sz6X3F-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:02:03 INFO - Running setup.py (path:/tmp/pip-eVzb9p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:02:03 INFO - Running setup.py (path:/tmp/pip-V2nToG-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:02:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:02:03 INFO - Running setup.py (path:/tmp/pip-aMDtmw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:02:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:02:03 INFO - Running setup.py install for manifestparser 23:02:03 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 23:02:03 INFO - Running setup.py install for mozcrash 23:02:04 INFO - Running setup.py install for mozdebug 23:02:04 INFO - Running setup.py install for mozdevice 23:02:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Running setup.py install for mozfile 23:02:04 INFO - Running setup.py install for mozhttpd 23:02:04 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Running setup.py install for mozinfo 23:02:04 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Running setup.py install for mozInstall 23:02:04 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Running setup.py install for mozleak 23:02:04 INFO - Running setup.py install for mozlog 23:02:04 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Running setup.py install for moznetwork 23:02:04 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 23:02:04 INFO - Running setup.py install for mozprocess 23:02:05 INFO - Running setup.py install for mozprofile 23:02:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 23:02:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 23:02:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 23:02:05 INFO - Running setup.py install for mozrunner 23:02:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 23:02:05 INFO - Running setup.py install for mozscreenshot 23:02:05 INFO - Running setup.py install for moztest 23:02:05 INFO - Running setup.py install for mozversion 23:02:05 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 23:02:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:02:05 INFO - Cleaning up... 23:02:05 INFO - Return code: 0 23:02:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:02:05 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')]} 23:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:05 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')]} 23:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:05 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 0x7fc8165a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', '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 23:02:05 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 23:02:05 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 23:02:05 INFO - Using env: {'DISPLAY': ':0', 23:02:05 INFO - 'HOME': '/home/cltbld', 23:02:05 INFO - 'LANG': 'en_US.UTF-8', 23:02:05 INFO - 'LANGUAGE': 'en_US:en', 23:02:05 INFO - 'LOGNAME': 'cltbld', 23:02:05 INFO - 'MAIL': '/var/mail/cltbld', 23:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:05 INFO - 'MOZ_NO_REMOTE': '1', 23:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:05 INFO - 'NO_EM_RESTART': '1', 23:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:05 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:05 INFO - 'SHELL': '/bin/bash', 23:02:05 INFO - 'SHLVL': '1', 23:02:05 INFO - 'TERM': 'linux', 23:02:05 INFO - 'TMOUT': '86400', 23:02:05 INFO - 'USER': 'cltbld', 23:02:05 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:05 INFO - '_': '/tools/buildbot/bin/python'} 23:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:02:05 INFO - Running setup.py (path:/tmp/pip-3brClt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 23:02:05 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)) 23:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:02:05 INFO - Running setup.py (path:/tmp/pip-kLxNbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 23:02:05 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)) 23:02:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:02:05 INFO - Running setup.py (path:/tmp/pip-MsC4yA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:02:06 INFO - Running setup.py (path:/tmp/pip-bpdPZH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 23:02:06 INFO - Running setup.py (path:/tmp/pip-KJAV36-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:02:06 INFO - Running setup.py (path:/tmp/pip-VRgtnu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:02:06 INFO - Running setup.py (path:/tmp/pip-isy8Qz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:02:06 INFO - Running setup.py (path:/tmp/pip-KeQ64I-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 23:02:06 INFO - Running setup.py (path:/tmp/pip-L6ergr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 23:02:06 INFO - Running setup.py (path:/tmp/pip-k2NeB3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:02:06 INFO - Running setup.py (path:/tmp/pip-xGnXFn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:02:06 INFO - Running setup.py (path:/tmp/pip-QlQPfj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:02:06 INFO - Running setup.py (path:/tmp/pip-Kc1fFv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:02:06 INFO - Running setup.py (path:/tmp/pip-WXVZ63-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:02:06 INFO - Running setup.py (path:/tmp/pip-gZLEjb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 23:02:06 INFO - Running setup.py (path:/tmp/pip-APIE5E-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 23:02:06 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)) 23:02:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 23:02:07 INFO - Running setup.py (path:/tmp/pip-BZmKnY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 23:02:07 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)) 23:02:07 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)) 23:02:07 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)) 23:02:07 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)) 23:02:07 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)) 23:02:07 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)) 23:02:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02:08 INFO - Downloading blessings-1.5.1.tar.gz 23:02:08 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 23:02:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 23:02:08 INFO - Installing collected packages: blessings 23:02:08 INFO - Running setup.py install for blessings 23:02:08 INFO - Successfully installed blessings 23:02:08 INFO - Cleaning up... 23:02:09 INFO - Return code: 0 23:02:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 23:02:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:02:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:02:09 INFO - Reading from file tmpfile_stdout 23:02:09 INFO - Current package versions: 23:02:09 INFO - argparse == 1.2.1 23:02:09 INFO - blessings == 1.5.1 23:02:09 INFO - blobuploader == 1.2.4 23:02:09 INFO - docopt == 0.6.1 23:02:09 INFO - manifestparser == 1.1 23:02:09 INFO - mozInstall == 1.12 23:02:09 INFO - mozcrash == 0.16 23:02:09 INFO - mozdebug == 0.1 23:02:09 INFO - mozdevice == 0.47 23:02:09 INFO - mozfile == 1.2 23:02:09 INFO - mozhttpd == 0.7 23:02:09 INFO - mozinfo == 0.9 23:02:09 INFO - mozleak == 0.1 23:02:09 INFO - mozlog == 3.1 23:02:09 INFO - moznetwork == 0.27 23:02:09 INFO - mozprocess == 0.22 23:02:09 INFO - mozprofile == 0.28 23:02:09 INFO - mozrunner == 6.11 23:02:09 INFO - mozscreenshot == 0.1 23:02:09 INFO - mozsystemmonitor == 0.0 23:02:09 INFO - moztest == 0.7 23:02:09 INFO - mozversion == 1.4 23:02:09 INFO - psutil == 3.1.1 23:02:09 INFO - requests == 1.2.3 23:02:09 INFO - wsgiref == 0.1.2 23:02:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 23:02: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')]} 23:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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', '-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 0x7fc8165a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', '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 23:02:09 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 23:02:09 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 23:02:09 INFO - Using env: {'DISPLAY': ':0', 23:02:09 INFO - 'HOME': '/home/cltbld', 23:02:09 INFO - 'LANG': 'en_US.UTF-8', 23:02:09 INFO - 'LANGUAGE': 'en_US:en', 23:02:09 INFO - 'LOGNAME': 'cltbld', 23:02:09 INFO - 'MAIL': '/var/mail/cltbld', 23:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:09 INFO - 'MOZ_NO_REMOTE': '1', 23:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:09 INFO - 'NO_EM_RESTART': '1', 23:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:09 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:09 INFO - 'SHELL': '/bin/bash', 23:02:09 INFO - 'SHLVL': '1', 23:02:09 INFO - 'TERM': 'linux', 23:02:09 INFO - 'TMOUT': '86400', 23:02:09 INFO - 'USER': 'cltbld', 23:02:09 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:09 INFO - '_': '/tools/buildbot/bin/python'} 23:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:09 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)) 23:02:09 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)) 23:02:09 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)) 23:02:09 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)) 23:02:09 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)) 23:02:09 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)) 23:02:09 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)) 23:02:09 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)) 23:02:09 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)) 23:02:09 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)) 23:02:09 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)) 23:02:09 INFO - Cleaning up... 23:02:09 INFO - Return code: 0 23:02:09 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 23:02: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')]} 23:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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')]} 23:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc8165a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', '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 23:02: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', 'jsonschema'] in /builds/slave/test-pgo/build 23:02: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 jsonschema 23:02:09 INFO - Using env: {'DISPLAY': ':0', 23:02:09 INFO - 'HOME': '/home/cltbld', 23:02:09 INFO - 'LANG': 'en_US.UTF-8', 23:02:09 INFO - 'LANGUAGE': 'en_US:en', 23:02:09 INFO - 'LOGNAME': 'cltbld', 23:02:09 INFO - 'MAIL': '/var/mail/cltbld', 23:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:09 INFO - 'MOZ_NO_REMOTE': '1', 23:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:09 INFO - 'NO_EM_RESTART': '1', 23:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:09 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:09 INFO - 'SHELL': '/bin/bash', 23:02:09 INFO - 'SHLVL': '1', 23:02:09 INFO - 'TERM': 'linux', 23:02:09 INFO - 'TMOUT': '86400', 23:02:09 INFO - 'USER': 'cltbld', 23:02:09 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:09 INFO - '_': '/tools/buildbot/bin/python'} 23:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:09 INFO - Downloading/unpacking jsonschema 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:02:11 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 23:02:11 INFO - Downloading/unpacking functools32 (from jsonschema) 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02: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 23:02:11 INFO - Downloading functools32-3.2.3-2.tar.gz 23:02:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 23:02:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 23:02:11 INFO - warning: no files found matching '*.txt' 23:02:11 INFO - no previously-included directories found matching 'build' 23:02:11 INFO - no previously-included directories found matching 'dist' 23:02:11 INFO - no previously-included directories found matching '.git*' 23:02:11 INFO - Installing collected packages: jsonschema, functools32 23:02:11 INFO - Running setup.py install for functools32 23:02:11 INFO - warning: no files found matching '*.txt' 23:02:11 INFO - no previously-included directories found matching 'build' 23:02:11 INFO - no previously-included directories found matching 'dist' 23:02:11 INFO - no previously-included directories found matching '.git*' 23:02:11 INFO - Successfully installed jsonschema functools32 23:02:11 INFO - Cleaning up... 23:02:11 INFO - Return code: 0 23:02:11 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 23:02:11 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')]} 23:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:11 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')]} 23:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:02:11 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 0x7fc8165a0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ff8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2acf630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, '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': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', '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 23:02:11 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 23:02:11 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 23:02:11 INFO - Using env: {'DISPLAY': ':0', 23:02:11 INFO - 'HOME': '/home/cltbld', 23:02:11 INFO - 'LANG': 'en_US.UTF-8', 23:02:11 INFO - 'LANGUAGE': 'en_US:en', 23:02:11 INFO - 'LOGNAME': 'cltbld', 23:02:11 INFO - 'MAIL': '/var/mail/cltbld', 23:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:11 INFO - 'MOZ_NO_REMOTE': '1', 23:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:11 INFO - 'NO_EM_RESTART': '1', 23:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:11 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:11 INFO - 'SHELL': '/bin/bash', 23:02:11 INFO - 'SHLVL': '1', 23:02:11 INFO - 'TERM': 'linux', 23:02:11 INFO - 'TMOUT': '86400', 23:02:11 INFO - 'USER': 'cltbld', 23:02:11 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:11 INFO - '_': '/tools/buildbot/bin/python'} 23:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:02:12 INFO - Downloading/unpacking flake8 23:02:12 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 23:02:12 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 23:02:12 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 23:02:12 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 23:02:12 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 23:02:12 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 23:02:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:02:13 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 23:02:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:02:13 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 23:02:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 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 23:02:13 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 23:02:14 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 23:02:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:02:14 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 23:02:14 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 23:02:14 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 23:02:14 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 23:02:14 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 23:02:14 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 23:02:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 23:02:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 23:02:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:02:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:02:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:02:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:02:14 INFO - no previously-included directories found matching 'docs/_build' 23:02:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:02:14 INFO - Running setup.py install for pep8 23:02:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:02:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:02:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:02:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:02:14 INFO - no previously-included directories found matching 'docs/_build' 23:02:14 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 23:02:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:02:14 INFO - Cleaning up... 23:02:14 INFO - Return code: 0 23:02:14 INFO - Running post-action listener: _resource_record_post_action 23:02:14 INFO - Running post-action listener: _start_resource_monitoring 23:02:14 INFO - Starting resource monitoring. 23:02:14 INFO - ##### 23:02:14 INFO - ##### Running install step. 23:02:14 INFO - ##### 23:02:14 INFO - Running pre-action listener: _resource_record_pre_action 23:02:14 INFO - Running main action method: install 23:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 23:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 23:02:14 INFO - Reading from file tmpfile_stdout 23:02:14 INFO - Detecting whether we're running mozinstall >=1.0... 23:02:14 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 23:02:14 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 23:02:15 INFO - Reading from file tmpfile_stdout 23:02:15 INFO - Output received: 23:02:15 INFO - Usage: mozinstall [options] installer 23:02:15 INFO - Options: 23:02:15 INFO - -h, --help show this help message and exit 23:02:15 INFO - -d DEST, --destination=DEST 23:02:15 INFO - Directory to install application into. [default: 23:02:15 INFO - "/builds/slave/test-pgo"] 23:02:15 INFO - --app=APP Application being installed. [default: firefox] 23:02:15 INFO - mkdir: /builds/slave/test-pgo/build/application 23:02:15 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'] 23:02:15 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 23:02:31 INFO - Reading from file tmpfile_stdout 23:02:31 INFO - Output received: 23:02:31 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 23:02:31 INFO - Running post-action listener: _resource_record_post_action 23:02:31 INFO - ##### 23:02:31 INFO - ##### Running run-tests step. 23:02:31 INFO - ##### 23:02:31 INFO - Running pre-action listener: _resource_record_pre_action 23:02:31 INFO - Running main action method: run_tests 23:02:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 23:02:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 23:02:31 INFO - Python 2.7.3 23:02:31 INFO - Return code: 0 23:02:31 INFO - grabbing minidump binary from tooltool 23:02:31 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')]} 23:02:31 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 0x2b60840>, '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 0x2acd6b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2acdb60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 23:02:31 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 23:02:31 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 23:02:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:02:31 INFO - Return code: 0 23:02:31 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 23:02:31 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 23:02:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 23:02:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 23:02:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 23:02:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 23:02:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 23:02:32 INFO - Return code: 0 23:02:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 23:02:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 23:02:32 INFO - Using env: {'DISPLAY': ':0', 23:02:32 INFO - 'HOME': '/home/cltbld', 23:02:32 INFO - 'LANG': 'en_US.UTF-8', 23:02:32 INFO - 'LANGUAGE': 'en_US:en', 23:02:32 INFO - 'LOGNAME': 'cltbld', 23:02:32 INFO - 'MAIL': '/var/mail/cltbld', 23:02:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:02:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 23:02:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:02:32 INFO - 'MOZ_NO_REMOTE': '1', 23:02:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 23:02:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:02:32 INFO - 'NO_EM_RESTART': '1', 23:02:32 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:02:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 23:02:32 INFO - 'PWD': '/builds/slave/test-pgo', 23:02:32 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 23:02:32 INFO - 'SHELL': '/bin/bash', 23:02:32 INFO - 'SHLVL': '1', 23:02:32 INFO - 'TERM': 'linux', 23:02:32 INFO - 'TMOUT': '86400', 23:02:32 INFO - 'USER': 'cltbld', 23:02:32 INFO - 'XDG_SESSION_COOKIE': 'b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055', 23:02:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:02:32 INFO - '_': '/tools/buildbot/bin/python'} 23:02:32 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 23:02:32 INFO - mozversion application_buildid: 20160103203025 23:02:32 INFO - mozversion application_changeset: 66b4c1052117aa21d74980b9c9978835da56b905 23:02:32 INFO - mozversion application_display_name: Nightly 23:02:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:02:32 INFO - mozversion application_name: Firefox 23:02:32 INFO - mozversion application_remotingname: firefox 23:02:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 23:02:32 INFO - mozversion application_vendor: Mozilla 23:02:32 INFO - mozversion application_version: 46.0a1 23:02:32 INFO - mozversion platform_buildid: 20160103203025 23:02:32 INFO - mozversion platform_changeset: 66b4c1052117aa21d74980b9c9978835da56b905 23:02:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 23:02:32 INFO - mozversion platform_version: 46.0a1 23:02:32 INFO - using testdate: 1451890952 23:02:32 INFO - actual date: 1451890952 23:02:32 INFO - starting webserver on 'localhost:48958' 23:02:32 INFO - SUITE-START | Running 3 tests 23:02:32 INFO - TEST-START | dromaeo_css 23:02:32 INFO - operating with platform_type : linux_ 23:02:32 INFO - Initialising browser for dromaeo_css test... 23:02:32 INFO - TEST-INFO | started process 18534 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv68Kxi/profile http://localhost:48958/getInfo.html) 23:02:36 INFO - PROCESS | 18534 | __metrics Screen width/height:1600/1200 23:02:36 INFO - PROCESS | 18534 | colorDepth:24 23:02:36 INFO - PROCESS | 18534 | Browser inner width/height: 1024/697 23:02:36 INFO - PROCESS | 18534 | __metrics 23:02:37 INFO - PROCESS | 18534 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:02:37 INFO - PROCESS | 18534 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:02:38 INFO - TEST-INFO | 18534: exit 0 23:02:38 INFO - Browser initialized. 23:02:38 INFO - Running cycle 1/1 for dromaeo_css test... 23:02:38 INFO - TEST-INFO | started process 18630 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpv68Kxi/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:02:49 INFO - PROCESS | 18630 | RSS: Main: 150331392 23:02:49 INFO - PROCESS | 18630 | 23:03:41 INFO - PROCESS | 18630 | 1451891021523 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] 23:05:49 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:48958/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48958/tests/dromaeo/cssquery-ext.html) 23:05:51 INFO - PROCESS | 18630 | RSS: Main: 251424768 23:05:51 INFO - PROCESS | 18630 | 23:08:53 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:48958/tests/dromaeo/cssquery-ext.html (next: http://localhost:48958/tests/dromaeo/cssquery-jquery.html) 23:08:54 INFO - PROCESS | 18630 | RSS: Main: 231387136 23:08:54 INFO - PROCESS | 18630 | 23:11:56 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:48958/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48958/tests/dromaeo/cssquery-mootools.html) 23:11:56 INFO - PROCESS | 18630 | RSS: Main: 230232064 23:11:56 INFO - PROCESS | 18630 | 23:14:58 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:48958/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48958/tests/dromaeo/cssquery-prototype.html) 23:14:59 INFO - PROCESS | 18630 | RSS: Main: 214937600 23:14:59 INFO - PROCESS | 18630 | 23:18:01 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:48958/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48958/tests/dromaeo/cssquery-yui.html) 23:18:02 INFO - PROCESS | 18630 | RSS: Main: 218988544 23:18:02 INFO - PROCESS | 18630 | 23:21:04 INFO - PROCESS | 18630 | Cycle 1(1): loaded http://localhost:48958/tests/dromaeo/cssquery-yui.html (next: http://localhost:48958/tests/dromaeo/cssquery-dojo.html) 23:21:04 INFO - PROCESS | 18630 | RSS: Main: 261287936 23:21:04 INFO - PROCESS | 18630 | 23:21:04 INFO - PROCESS | 18630 | __start_tp_report 23:21:04 INFO - PROCESS | 18630 | _x_x_mozilla_page_load 23:21:04 INFO - PROCESS | 18630 | _x_x_mozilla_page_load_details 23:21:04 INFO - PROCESS | 18630 | |i|pagename|runs| 23:21:04 INFO - PROCESS | 18630 | |0;dojo.html;3128.7340576051065;3134.091113577063;3216.6461689214198;3223.355328934214;3245.3996010738024;5036.194208926572;5095.108356037693;5144.819931302405;5184.481551844814;5219.42586315505;5148.845534633958;5193.428722840485;5226.4512226216175;5263.0526505229045;5263.49996750309;4680.78936447859;4710.952890471094;4731.952680473186;4738.076075165344;4813.181759100961;4867.075255701423;4881.804727810883;4886.755662216893;4896.534829191239;4939.357883475143;4619.930701039487;4674.111918735463;4734.83428080019;4755.35802666639;4797.040591881603;4806.4712881583;4817.891884866465;4820.68665536739;4828.710277383333;4857.878553036202;4791.5687588117235;4796.5203479651755;4797.784099715521;4810.711357318537;4825.662203645747;4920.926186107211;5013.849584512471;5031.496850314976;5117.385913690381;5129.538341549279;5505.898820235929;5543.390227075019;5548.223248745179;5554.750036248338;5557.943990641806;5480.479354461319;5550.389457159749;5562;5570.721463926788;5582.553395728332;5154.92267615986;5202.843914682528;5237.214417837355;5255.921161182585;5270.077736396153;5581.972090139523;5612.326520817528;5623.268975033219;5636.85907852307;5685.658860468385;5236.136037553837;5348.973255133699;5413;5427.457254274541;5457.263269458573;5436.700981446058;5535.612507124543;5610.971945140248;5631.690257035821;5672.574556908248;5488.286522752017;5506.91739623906;5511.944880551223;5521.365043020104;5523.585731070186;5520.392756796749;5520.66875987434;5524.558035357242;5529.751161197756;5529.944700552943;4056.3104272273786;4083.9795801020805;4129.070959034193;4160.625543701081;4175.164967006611;3811.27585758705;3821.0256384621744;3826.4642949987024;3860.8069596520622;3864.8067596620617;5247.737613119329;5265.078611243017;5273.815416460406;5282.867928301823;5288.576913846883;5386.380566234855;5476.91784623231;5477.287952566141;5479.75341109651;5561.972190139104;5227.817026404057;5230.843074707689;5231.136862417658;5281.419043905167;5287.048331300326;4627.028324051919;4629.976850115728;4631.652626053059;4666.650001249852;4676.462206846256;5624.465675760878;5734.197212390352;5770.163326317745;5790.536757059425;5792.536597072309;5337.439568845371;5446.346438427414;5468.808591699271;5529.502344788988;5538.030844602259;5715.599908006399;5716.79991200306;5718.513926316144;5723.112917497794;5758.107493338539;5366.543843773323;5416.458354164552;5417.918731218956;5432.837014889559;5433.728313584384;5379.327584051994;5480.3971563128825;5536.169574563848;5548.3619383769765;5558.861028474321;5389.649672771257;5391.487808658171;5392.299001129828;5393.083175860034;5398;5370.436104209002;5379.354477462573;5392.191171324333;5402.216678581663;5451.863703407288;5221.086309895829;5289.894202115859;5323.0950738373795;5329.973350133225;5390.892182156414;5405.405405405481;5424.810131645373;5426.810061647823;5432.456754324536;5473.28847249855;5080.695158290514;5314.070037743457;5314.8937021260135;5316.282301889196;5319.361676598833 23:21:04 INFO - PROCESS | 18630 | |1;ext.html;522.8405336372405;529.1586377659521;536.8013834881094;553.3138907754386;557.5595279729014;27866.16401507953;28392;28419.715802841965;28476.43047139056;35947.64052359475;38914.8054259729;39407.605923940755;39512.802435987855;39693.80153099238;39797.60202397975;8306.75079747607;8477.152284771504;8478.321734261275;8479.19447652472;8481.491110533389;7440;7576.0908690956885;9825.213982881352;9972.850407243897;10009.649662261822;9829.262805289596;9909.752256193617;9912.801743965116;9921.652742154027;9943.602255909755;7551.509151905108;7706.884396734054;9610.615575376976;9776.95111524445;9786.804263914717;9819.803603927952;9952.651657191964;10018.09837114656;10027.89972100277;10050.346727462691;35534.64465355365;35748.64251357479;36021.459678104846;36113.63886361155;36188.27623447542;3188.537662038991;3225.854836532362;3298.752593555469;3332.2002719347183;3609.404448266033;27459.17622471329;27688.723112769017;27788.95373155119;28980.130596082152;29988.8500557498;3478.739094567892;3611.56661200655;3637.1270894985278;3642.0894776305922;3669.94495082574;274633;275421;276317;276526;276767;49962;50973.490265097615;58478.70760646254;58564;59807.700961495786;53095.73452132715;53129.734351328;53387.46612533903;53692.19461708077;53717.73141134269;14178.787318190236;14239.92880035614;14254.144751314954;14266.429342826379;14285;10948.671539853816;11001.449927503752;11082;11085.944570277097;11229.606963756229;18982.33561825357;19332.226710931685;19624.21503139887;19671.803281967284;19726.210951561778;7103.538270012433;7185.640717964081;7233.963830180815;7293.52592081513;7319.743808966767;803.7026300268938;888.9777755556163;909.8726178335038;991.2020823237219;1011.2718842433436;25349.74650253511;25989;27160.45679086407;27228.727712723015;30028.24929376783;914.1818072824917;925.4678559828126;939.5349302095507;946.2099147212155;955.7658373698488;15771.211439427983;16271.183059537112;16295.837041629431;16812.74780878288;16903.408380706616;373899;380403;382240;382794;382986;52669.736651316496;53209.733951329996;53279.73360133252;54787.45212547903;54892;1099.2360309584922;1333.2667033131934;1340.684939039325;1365.1672479787321;1374.2785037855206;22351.552968940206;27442.725572744017;28179.295517612223;29395;30058.54912176363;44534.331985019606;45065.32402014038;45169.77415112904;45203.77398112988;45328;290570;295480;295699;301516;429383;41055.689152638544;41986;42044.79552044893;42094.36858447187;42819.14361712811;44649;45284.54715452803;45297.32054019258;45324.32013519866;45692.314615280135;37221;38226.426603601525;38451.615483845926;38608.61391386163;40010;38305.18888492426;38340.80829595834;39482.80258598689;39512.20975580415;39767;36719.41007374078;36952.44571331486;37107.25785484221;37616.24767504689;38018.619813802616;32817.34365312633;34936;35090;35422.645773542965;35457.82271088628;23940.88029559841;24631;25142.74857251404;25355;25477 23:21:04 INFO - PROCESS | 18630 | |2;jquery.html;339.3941813862256;344.8241396887588;347.2343482620821;348.6983759048424;353.92036791721864;13938.651533711662;14417.134971901693;16071.116088615136;16230.675386492278;16963.575910602256;14548.781768273484;14585.34365953532;14676.412943482248;14689.118652880834;14730.18983955882;5248.317718696583;5262.578993680516;5340.412554618989;5344.385395679507;5351.224072509483;4072.572379900112;4198.6850986176005;5301.840944771663;5770.711464426783;5929.792457263975;5886.793962211324;5890.676012819315;5912.9113063304085;5930.199423077894;5943.078822782476;5745.597808153431;5850.6782126983;5851.385604511529;5851.38560451155;5860.794872179475;5114.590832733373;5125.3080834087295;5136.075506408845;5136.845894623168;5149.6910185389;11992.64022079339;12296.139270251086;12323.876761232363;12347.38263086842;18148.364807231683;2025.7771645119026;2091.6757902525133;2108.947276318089;2122.724045874042;2166.750823655284;8810.339224558184;8885.378023538355;8900.109989001114;8942.68700595476;9118.316126290554;1638.2873450049267;1645.539249010279;1662.7672125902384;1668.382698401599;1698.3376483171573;60719.69640151771;62267.7546449073;62808.37191628071;63653.68173159151;63856.68071659612;10078.193744500422;10102.898971010343;10108;10138.695839124837;10226.897731022744;13285.601431957057;13307;13309.40107695156;13310.866891331156;13316.6670833228;7199.77603807354;7207.92792072083;7232.638368081575;7254.492185546961;7367.631618419057;6697.296783837724;6708.597484150967;6717.496187785936;6793.320667933266;6826.93173068263;4371.191329604034;4444.200043992112;4450.1989641864775;4468.396766436555;4480.574345437243;1714.5113642611796;1767.328415202215;1776.3338747969512;1817.963640727178;1838.3106335124328;389.2642904909723;393.7519362801474;408.6669364467949;726.3862036579083;771.124773382204;9955.352902061342;10277.691669249934;10289.3311934724;10317.27779055474;10615.31000484966;417.6470882104617;419.35419454040436;431.11836294777254;438.6074463355279;439.969202155846;5524.3370795504;5713.628614140068;5733.713314334266;5758.107493338539;6032.698365081728;355541;511756;516205;523987;527448;64413.35586644167;72955.63522182356;73717;74740.62629686817;75834.24165758272;485.4368932038818;498.3496537019152;499.5928318420476;500.5395036566368;500.57201093065635;8708.651653933772;9712.75718107053;9924.908260091528;9990.850137247802;10344.689659310232;35856;36817.815910920275;36841.44737828881;36982.8150859244;37043.62956370402;40566;41468;41830;43476;44713.55286447094;9486.715398538056;9778.168855647065;10061.949690251502;10065.899341006789;10074.748131296483;16634;16955.745663815298;17107.23017464192;17476.73784893202;17744.91127544354;13072.607821764981;13118.409671564994;13182.868171318163;13433.932830335785;14004.579862604138;11971.76056478883;13910.860891391361;14200.78698819498;14548.199849008406;15062.623434414227;13362.799558006443;14112.858871411154;14204.218767967861;14325;14990.17554034495;9015.772367450132;9439.480828554495;9478.431294122374;9532.90467095348;9542.761430964281;9666.130048295687;9733.659321923698;10119.544620491948;14553.272336382926;14575.125492470486 23:21:04 INFO - PROCESS | 18630 | |3;mootools.html;1264.096171237565;1453.7237924794288;1467.4203689542628;1601.383467365064;1742.8867123636962;6898.413634841038;7493.587852668101;7623.199564045772;7657.808554786133;7659.655315510801;7596.164421913585;7786.065672119354;7795.92204077959;7802;7802.960985195066;1997.410763824668;2038.4292398128548;2042.4893776555862;2228.8551244169075;2248.269312473453;2229.9108035678632;2277.9886100569556;2278.487340348425;2279.566882292359;2279.794818466338;2218.456478162844;2224.2326397392953;2297.3337732057685;2299.3446867642724;2300.1029598456616;2275.6814046033487;2275.9317220483495;2292.9197478088354;2311.04091801902;2320.4662927526597;2235.5417139486367;2246.7753224677563;2261.2876943762826;2262.1290803040783;2268.194790849241;7565.924340756577;7581.431392645519;7671.386289096915;7677.654505547208;7683.500572462772;4716.646251531149;4843.055604157191;4845.152098382804;4849;4850.660453768238;3081.6610172880964;3107.8912238071784;3110.5956225690516;3110.6578276389578;3234.36929798687;1071.3518321415588;1095.8246680531076;1106.4523061084815;1151.435796459737;1162.3839365136491;10499.475026248734;10671.19966002553;10688.091512221548;10696.251262411633;10723.302985306009;4092.508898932147;4107.712460127762;4167.666586673059;4258.403823464718;4268.551802060739;8638.913610863936;8730.563471826383;8731.956340218258;8735.912640873637;8738.344624153215;4533.909321813545;4557.339185818104;4566.383538222364;4566.680332376702;4567.063751930847;4130.91738165241;4161.146964872194;4170.457840480779;4173.833046678099;4173.979130104391;3192.4892017277125;3236.368908062905;3354.26206234628;3370.0732298618077;3452.913677158091;1055.9524821383056;1066.1257768629805;1076.4187338837096;1077.3589714120087;1084.143526613982;1053.510117795229;1054.6150655010865;1107.5126944144552;1163.4880652513036;1264.6585421936027;7133.322334378226;7303.671334789948;7383.07711536058;7385.6307184640555;7391.371733402613;615.9414855588711;619.9752009919642;630.7445484578753;635.3202073781102;773.8431045586772;5650.943490565124;5783.363829978699;5869.178315035899;5881.882362352729;5884.499817515473;9363.719088427359;9578.137967582812;9593.904060959441;9616.51917404141;9630.133288004114;8870.112988701207;9001.18989290967;9497.287703422133;9507.239420846454;9532.18976387001;7313;7376.262373762688;7381.188069312371;7429.07136607924;7429.405647548183;7261.891071633824;7352.558846469229;7399.963000184965;7411.481196316422;7412.777616671508;7919.802004949923;8265.421420500506;8548.658053677784;8759.03650598421;8772.122787721177;8223.301019413417;8432.030316513434;8433.704820331259;8434.620442079999;8615.526146062026;6663;6772.762953296611;6773.966130169318;6780.118584583973;6783.084283621648;7403.7408690695565;7422.70309187648;7427.368673662799;7476.065491813523;7595.5822429766895;7012.298770122947;7081.18566364854;7109.502334836719;7160.212376638461;7302.853942921218;7075.5047146699235;7125.82185445368;7212.098487689039;7272.23641517633;7357.374623157091;7246.7101315946775;7303.30618591233;7304.342609165201;7305.488615796843;7314.634268286671;6508.544401891822;6617.900731488935;6625.933740662532;6635.502337324817;6647.069410282467;6669.4664426844765;6727.192736871411;6732.360425759545;6736.090627765189;6736.93263067363 23:21:04 INFO - PROCESS | 18630 | |4;prototype.html;333.5597011944233;334.7573009568063;337.16887871397;341.259466956704;345.94464885618305;5653.717314134287;5786.276715410574;5789.594728369016;5802.41975802419;5856.063029915214;5638.097904335307;5735;5736.340320863092;5745.138229265613;5749.223854779603;4522.389477420539;4522.932156017662;4530.116627257669;4531.048479819242;4531.252343363341;4339.522652508222;4397.890052748675;4421.6683748718815;4486.798094085758;4509.77451127444;4433.9113217735785;4442.489113751912;4467.441569803775;4468.508464068966;4473.776311184428;4450;4476.507584165755;4477.171723231213;4478.529754375792;4480.820767169309;3952.7430717003303;3962.9603703963166;3964.4846169998004;3966.5835087315704;3975.1652153047894;5418.485243901823;5535.418781027975;5540.058190107691;5566.081596536566;5583.6928968906695;5132.076226279269;5133.948660513384;5137.357830271216;5138.460461651547;5142.331496905415;5806.158107074492;6089.695515224221;6094.451499365078;6095.634261944253;6099.176611157525;4180.226658068236;4196.118815048843;4270;4278.229918614648;4278.871633850989;6250.343713910065;6327.17746692927;6340.841478963017;6349.428551430347;6352.301246862888;4382.320740285261;4384.714993525411;4386.1008493258805;4386.605205531518;4387.254166791653;4296.656267498593;4443.622292105208;4444.622207112367;4444.688871778944;4448.666350023761;5105.7191854448365;5118.129917913963;5118.129917913963;5135;5165.61257905651;6117.235345581802;6143.56995010345;6145.170401995762;6148.6925653717135;6149.723262453201;1550.046721266413;1568.615689156164;1569.4899157773768;1570.3169121432213;1570.46604154588;1034.234666346898;1045.341434896026;1052.9789404211872;1057.4765491081964;1059.936403815758;5806.361300256968;5827.65034097947;5850.531957443394;5852.385499522574;5857.297124345106;6282.654454004982;6308.053791931247;6315.842103947438;6323.462505687068;6323.7786677466065;5852.824415267549;5865;5872.354041055481;5910.527157827363;5911.704414779244;3311.172206948263;3407.5059116428474;3410.3179364127272;3413.197898493852;3413.2832105258176;6501.122348482989;6543.607383556907;6547.672616369163;6551.868962620721;6563.901541476882;6419.871602567922;6429.58207716497;6433.581817181868;6445.677716114175;6460.3862633049785;6382.20222472191;6523.054157147092;6536.477081833442;6546.70539825709;6547.770828021092;6099.9390006099375;6247.812565623039;6267.5299352549655;6285.528585356025;6287.874242515216;6138.969305153446;6186.566940314135;6237.033259844731;6243.375662433902;6286.277078136073;6546.116274302908;6580.440662543738;6584.539082264387;6607.405333519814;6612.173478315211;4312.827486900489;4397.406350142818;4401.251787196248;4411.029573493826;4411.139827733561;6353.110564520878;6355.459785918249;6361.968190159019;6372.9362706374195;6373.681315934092;6180.7527698891545;6181.227346581677;6182.938170618416;6184.134221208944;6186.257649082139;6026.156338112755;6230.408111229426;6255.655938923403;6258.718357674006;6261.718222680081;6067.817965461043;6072.787452439144;6079.969600151971;6081.1486391906055;6081.27024757032;6200.720967556561;6208.875822483616;6209.565330426827;6212.068189771389;6216.72024758896;5950.761969521171;6073.089036644538;6075.878482430415;6077;6079.179310792986 23:21:04 INFO - PROCESS | 18630 | |5;yui.html;731.4002517935293;807.3742849291798;810.4165001199142;839.1692224697551;858.0261403307246;13724.725505489885;13898.51355202568;13916.234607096605;13931.09447885888;13945.442182312709;12254.203476774004;12371.69070773231;12613.369331533433;13106.213627182351;13285.33573321335;750.7822731407886;753.0473950452682;754.2156157596094;758.8368500772333;773.6711897443564;758.6055251269337;758.9905425783722;763.6334559411486;766.1954947305335;807.1202389395557;778.1012930065783;826.4958375391006;832.7501749475164;843.3421930893912;846.318713435684;789.9690903371098;793.309820456201;795.9880601790978;796.5220867479524;797.2665148063795;578.0808514461984;607.7720854679495;614.6987975891825;615.003694015693;616.1927874484395;12095.213811102338;12137.514499420013;12154.696132596668;12156.756864862742;12224.511019559208;10021.24840636948;10058.295919285652;10248.846267305997;10671.626493072705;10762;9462.90537094634;9526.333156679035;9534.809303813954;9721.076497732704;9789.608415663364;3359.5800524934384;3410.1474631342167;3425.2293234022145;3425.400554902907;3429.691327780487;40619.7969010156;41992.79003604963;42133;42221.78889105566;46107.538924611;9539.236861051098;9543.713688589354;9598.760030999281;9770.951145244371;9894.950525247328;17421.04184269852;17470.912645436692;17498.12509374526;17503.212355444037;17512;6171.228596425447;6784.423324017415;7218.314260145278;7683.0780306363595;7849.882251766228;4050.4531888194715;4133.607307305801;4147.8963025924595;4178.6657067434535;4230.344296634026;2991.9102426927225;3011.1869795155185;3015.381846721417;3030.696930306996;3031.1512776422637;493.23302264978304;499.6302735975352;500.27709959109467;510.6272421132594;517.2551525802832;582.1878479521044;604.091527815036;617.3301967365459;630.1996464490072;684.6200358800813;7829.804254893673;7860.292573668397;7966.880496792553;8143.104258531557;8223.21879421454;680.4012469027224;686.3411125319649;687.924328323884;689.8309914070984;694.4826104552141;3665.9633403666157;3745.550533935945;4055.6679909052414;4243.724157929724;4281.357796330513;51982.74008629932;52868.471315287126;53968.190477142874;54266;54340.72829635826;43784.78107609441;44520.3321950171;44535.886602834544;45821.770891146;47362.76318618454;39685.40471892924;40257.79871100684;47180.5281947183;48094.5190548097;48200.03599927982;7923.20767923203;7999.320057795153;8055.959720201361;8071.515709057476;8216.589170541329;33280.33439331152;34882;34895.41990792201;35185.648143518236;35469.11327216737;38683.61316386913;39784.20431591294;40844.79577602093;40911.1817763649;42582.787086064374;10902.727431814268;10932.453377331261;11094.445277736242;11117.332960022424;11191.2725672831;11548.249363791327;11594.362310072689;11748.236364636272;11801.645950621494;12201.755964880831;11093.667189984313;11159.163062770487;11162.49768760424;11165.944170279097;11172.888271117185;10499.94750026245;10545.31455455393;10564.26050176511;10584.206184536037;10594.788104238027;11070.833937491105;11070.889291106985;11107.666769996913;11159.72100697489;11187.272827266203;8640.524771137647;8927.464352138892;8999.505027223566;9120.589573469342;9164.037776033421;8628.78428039304;8663.393562450568;9111.544422778701;9179.265658747418;9263.907360926305 23:21:04 INFO - PROCESS | 18630 | __end_tp_report 23:21:04 INFO - PROCESS | 18630 | __start_cc_report 23:21:04 INFO - PROCESS | 18630 | _x_x_mozilla_cycle_collect,837 23:21:04 INFO - PROCESS | 18630 | __end_cc_report 23:21:04 INFO - PROCESS | 18630 | __startTimestamp1451892064912__endTimestamp 23:21:04 INFO - PROCESS | 18630 | 23:21:04 INFO - PROCESS | 18630 | ------- Summary: start ------- 23:21:04 INFO - PROCESS | 18630 | Number of tests: 6 23:21:04 INFO - PROCESS | 18630 | 23:21:04 INFO - PROCESS | 18630 | [#0] dojo.html Cycles:165 Average:5144.01 Median:5319.36 stddev:552.63 (10.4%) stddev-sans-first:531.23 23:21:04 INFO - PROCESS | 18630 | Values: 3128.7 3134.1 3216.6 3223.4 3245.4 5036.2 5095.1 5144.8 5184.5 5219.4 5148.8 5193.4 5226.5 5263.1 5263.5 4680.8 4711.0 4732.0 4738.1 4813.2 4867.1 4881.8 4886.8 4896.5 4939.4 4619.9 4674.1 4734.8 4755.4 4797.0 4806.5 4817.9 4820.7 4828.7 4857.9 4791.6 4796.5 4797.8 4810.7 4825.7 4920.9 5013.8 5031.5 5117.4 5129.5 5505.9 5543.4 5548.2 5554.8 5557.9 5480.5 5550.4 5562.0 5570.7 5582.6 5154.9 5202.8 5237.2 5255.9 5270.1 5582.0 5612.3 5623.3 5636.9 5685.7 5236.1 5349.0 5413.0 5427.5 5457.3 5436.7 5535.6 5611.0 5631.7 5672.6 5488.3 5506.9 5511.9 5521.4 5523.6 5520.4 5520.7 5524.6 5529.8 5529.9 4056.3 4084.0 4129.1 4160.6 4175.2 3811.3 3821.0 3826.5 3860.8 3864.8 5247.7 5265.1 5273.8 5282.9 5288.6 5386.4 5476.9 5477.3 5479.8 5562.0 5227.8 5230.8 5231.1 5281.4 5287.0 4627.0 4630.0 4631.7 4666.7 4676.5 5624.5 5734.2 5770.2 5790.5 5792.5 5337.4 5446.3 5468.8 5529.5 5538.0 5715.6 5716.8 5718.5 5723.1 5758.1 5366.5 5416.5 5417.9 5432.8 5433.7 5379.3 5480.4 5536.2 5548.4 5558.9 5389.6 5391.5 5392.3 5393.1 5398.0 5370.4 5379.4 5392.2 5402.2 5451.9 5221.1 5289.9 5323.1 5330.0 5390.9 5405.4 5424.8 5426.8 5432.5 5473.3 5080.7 5314.1 5314.9 5316.3 5319.4 23:21:04 INFO - PROCESS | 18630 | 23:21:04 INFO - PROCESS | 18630 | [#1] ext.html Cycles:180 Average:48942.90 Median:209210.81 stddev:86847.77 (41.5%) stddev-sans-first:87015.31 23:21:04 INFO - PROCESS | 18630 | Values: 522.8 529.2 536.8 553.3 557.6 27866.2 28392.0 28419.7 28476.4 35947.6 38914.8 39407.6 39512.8 39693.8 39797.6 8306.8 8477.2 8478.3 8479.2 8481.5 7440.0 7576.1 9825.2 9972.9 10009.6 9829.3 9909.8 9912.8 9921.7 9943.6 7551.5 7706.9 9610.6 9777.0 9786.8 9819.8 9952.7 10018.1 10027.9 10050.3 35534.6 35748.6 36021.5 36113.6 36188.3 3188.5 3225.9 3298.8 3332.2 3609.4 27459.2 27688.7 27789.0 28980.1 29988.9 3478.7 3611.6 3637.1 3642.1 3669.9 274633.0 275421.0 276317.0 276526.0 276767.0 49962.0 50973.5 58478.7 58564.0 59807.7 53095.7 53129.7 53387.5 53692.2 53717.7 14178.8 14239.9 14254.1 14266.4 14285.0 10948.7 11001.4 11082.0 11085.9 11229.6 18982.3 19332.2 19624.2 19671.8 19726.2 7103.5 7185.6 7234.0 7293.5 7319.7 803.7 889.0 909.9 991.2 1011.3 25349.7 25989.0 27160.5 27228.7 30028.2 914.2 925.5 939.5 946.2 955.8 15771.2 16271.2 16295.8 16812.7 16903.4 373899.0 380403.0 382240.0 382794.0 382986.0 52669.7 53209.7 53279.7 54787.5 54892.0 1099.2 1333.3 1340.7 1365.2 1374.3 22351.6 27442.7 28179.3 29395.0 30058.5 44534.3 45065.3 45169.8 45203.8 45328.0 290570.0 295480.0 295699.0 301516.0 429383.0 41055.7 41986.0 42044.8 42094.4 42819.1 44649.0 45284.5 45297.3 45324.3 45692.3 37221.0 38226.4 38451.6 38608.6 40010.0 38305.2 38340.8 39482.8 39512.2 39767.0 36719.4 36952.4 37107.3 37616.2 38018.6 32817.3 34936.0 35090.0 35422.6 35457.8 23940.9 24631.0 25142.7 25355.0 25477.0 23:21:04 INFO - PROCESS | 18630 | 23:21:04 INFO - PROCESS | 18630 | [#2] jquery.html Cycles:180 Average:26266.50 Median:2309.02 stddev:80450.92 (3484.2%) stddev-sans-first:80653.05 23:21:04 INFO - PROCESS | 18630 | Values: 339.4 344.8 347.2 348.7 353.9 13938.7 14417.1 16071.1 16230.7 16963.6 14548.8 14585.3 14676.4 14689.1 14730.2 5248.3 5262.6 5340.4 5344.4 5351.2 4072.6 4198.7 5301.8 5770.7 5929.8 5886.8 5890.7 5912.9 5930.2 5943.1 5745.6 5850.7 5851.4 5851.4 5860.8 5114.6 5125.3 5136.1 5136.8 5149.7 11992.6 12296.1 12323.9 12347.4 18148.4 2025.8 2091.7 2108.9 2122.7 2166.8 8810.3 8885.4 8900.1 8942.7 9118.3 1638.3 1645.5 1662.8 1668.4 1698.3 60719.7 62267.8 62808.4 63653.7 63856.7 10078.2 10102.9 10108.0 10138.7 10226.9 13285.6 13307.0 13309.4 13310.9 13316.7 7199.8 7207.9 7232.6 7254.5 7367.6 6697.3 6708.6 6717.5 6793.3 6826.9 4371.2 4444.2 4450.2 4468.4 4480.6 1714.5 1767.3 1776.3 1818.0 1838.3 389.3 393.8 408.7 726.4 771.1 9955.4 10277.7 10289.3 10317.3 10615.3 417.6 419.4 431.1 438.6 440.0 5524.3 5713.6 5733.7 5758.1 6032.7 355541.0 511756.0 516205.0 523987.0 527448.0 64413.4 72955.6 73717.0 74740.6 75834.2 485.4 498.3 499.6 500.5 500.6 8708.7 9712.8 9924.9 9990.9 10344.7 35856.0 36817.8 36841.4 36982.8 37043.6 40566.0 41468.0 41830.0 43476.0 44713.6 9486.7 9778.2 10061.9 10065.9 10074.7 16634.0 16955.7 17107.2 17476.7 17744.9 13072.6 13118.4 13182.9 13433.9 14004.6 11971.8 13910.9 14200.8 14548.2 15062.6 13362.8 14112.9 14204.2 14325.0 14990.2 9015.8 9439.5 9478.4 9532.9 9542.8 9666.1 9733.7 10119.5 14553.3 14575.1 23:21:04 INFO - PROCESS | 18630 | 23:21:04 INFO - PROCESS | 18630 | [#3] mootools.html Cycles:180 Average:5440.76 Median:6621.92 stddev:2855.85 (43.1%) stddev-sans-first:2846.60 23:21:04 INFO - PROCESS | 18630 | Values: 1264.1 1453.7 1467.4 1601.4 1742.9 6898.4 7493.6 7623.2 7657.8 7659.7 7596.2 7786.1 7795.9 7802.0 7803.0 1997.4 2038.4 2042.5 2228.9 2248.3 2229.9 2278.0 2278.5 2279.6 2279.8 2218.5 2224.2 2297.3 2299.3 2300.1 2275.7 2275.9 2292.9 2311.0 2320.5 2235.5 2246.8 2261.3 2262.1 2268.2 7565.9 7581.4 7671.4 7677.7 7683.5 4716.6 4843.1 4845.2 4849.0 4850.7 3081.7 3107.9 3110.6 3110.7 3234.4 1071.4 1095.8 1106.5 1151.4 1162.4 10499.5 10671.2 10688.1 10696.3 10723.3 4092.5 4107.7 4167.7 4258.4 4268.6 8638.9 8730.6 8732.0 8735.9 8738.3 4533.9 4557.3 4566.4 4566.7 4567.1 4130.9 4161.1 4170.5 4173.8 4174.0 3192.5 3236.4 3354.3 3370.1 3452.9 1056.0 1066.1 1076.4 1077.4 1084.1 1053.5 1054.6 1107.5 1163.5 1264.7 7133.3 7303.7 7383.1 7385.6 7391.4 615.9 620.0 630.7 635.3 773.8 5650.9 5783.4 5869.2 5881.9 5884.5 9363.7 9578.1 9593.9 9616.5 9630.1 8870.1 9001.2 9497.3 9507.2 9532.2 7313.0 7376.3 7381.2 7429.1 7429.4 7261.9 7352.6 7400.0 7411.5 7412.8 7919.8 8265.4 8548.7 8759.0 8772.1 8223.3 8432.0 8433.7 8434.6 8615.5 6663.0 6772.8 6774.0 6780.1 6783.1 7403.7 7422.7 7427.4 7476.1 7595.6 7012.3 7081.2 7109.5 7160.2 7302.9 7075.5 7125.8 7212.1 7272.2 7357.4 7246.7 7303.3 7304.3 7305.5 7314.6 6508.5 6617.9 6625.9 6635.5 6647.1 6669.5 6727.2 6732.4 6736.1 6736.9 23:21:04 INFO - PROCESS | 18630 | 23:21:04 INFO - PROCESS | 18630 | [#4] prototype.html Cycles:180 Average:5140.91 Median:5817.01 stddev:1535.29 (26.4%) stddev-sans-first:1496.60 23:21:04 INFO - PROCESS | 18630 | Values: 333.6 334.8 337.2 341.3 345.9 5653.7 5786.3 5789.6 5802.4 5856.1 5638.1 5735.0 5736.3 5745.1 5749.2 4522.4 4522.9 4530.1 4531.0 4531.3 4339.5 4397.9 4421.7 4486.8 4509.8 4433.9 4442.5 4467.4 4468.5 4473.8 4450.0 4476.5 4477.2 4478.5 4480.8 3952.7 3963.0 3964.5 3966.6 3975.2 5418.5 5535.4 5540.1 5566.1 5583.7 5132.1 5133.9 5137.4 5138.5 5142.3 5806.2 6089.7 6094.5 6095.6 6099.2 4180.2 4196.1 4270.0 4278.2 4278.9 6250.3 6327.2 6340.8 6349.4 6352.3 4382.3 4384.7 4386.1 4386.6 4387.3 4296.7 4443.6 4444.6 4444.7 4448.7 5105.7 5118.1 5118.1 5135.0 5165.6 6117.2 6143.6 6145.2 6148.7 6149.7 1550.0 1568.6 1569.5 1570.3 1570.5 1034.2 1045.3 1053.0 1057.5 1059.9 5806.4 5827.7 5850.5 5852.4 5857.3 6282.7 6308.1 6315.8 6323.5 6323.8 5852.8 5865.0 5872.4 5910.5 5911.7 3311.2 3407.5 3410.3 3413.2 3413.3 6501.1 6543.6 6547.7 6551.9 6563.9 6419.9 6429.6 6433.6 6445.7 6460.4 6382.2 6523.1 6536.5 6546.7 6547.8 6099.9 6247.8 6267.5 6285.5 6287.9 6139.0 6186.6 6237.0 6243.4 6286.3 6546.1 6580.4 6584.5 6607.4 6612.2 4312.8 4397.4 4401.3 4411.0 4411.1 6353.1 6355.5 6362.0 6372.9 6373.7 6180.8 6181.2 6182.9 6184.1 6186.3 6026.2 6230.4 6255.7 6258.7 6261.7 6067.8 6072.8 6080.0 6081.1 6081.3 6200.7 6208.9 6209.6 6212.1 6216.7 5950.8 6073.1 6075.9 6077.0 6079.2 23:21:04 INFO - PROCESS | 18630 | 23:21:04 INFO - PROCESS | 18630 | [#5] yui.html Cycles:180 Average:12914.23 Median:46644.03 stddev:14674.98 (31.5%) stddev-sans-first:14687.63 23:21:04 INFO - PROCESS | 18630 | Values: 731.4 807.4 810.4 839.2 858.0 13724.7 13898.5 13916.2 13931.1 13945.4 12254.2 12371.7 12613.4 13106.2 13285.3 750.8 753.0 754.2 758.8 773.7 758.6 759.0 763.6 766.2 807.1 778.1 826.5 832.8 843.3 846.3 790.0 793.3 796.0 796.5 797.3 578.1 607.8 614.7 615.0 616.2 12095.2 12137.5 12154.7 12156.8 12224.5 10021.2 10058.3 10248.8 10671.6 10762.0 9462.9 9526.3 9534.8 9721.1 9789.6 3359.6 3410.1 3425.2 3425.4 3429.7 40619.8 41992.8 42133.0 42221.8 46107.5 9539.2 9543.7 9598.8 9771.0 9895.0 17421.0 17470.9 17498.1 17503.2 17512.0 6171.2 6784.4 7218.3 7683.1 7849.9 4050.5 4133.6 4147.9 4178.7 4230.3 2991.9 3011.2 3015.4 3030.7 3031.2 493.2 499.6 500.3 510.6 517.3 582.2 604.1 617.3 630.2 684.6 7829.8 7860.3 7966.9 8143.1 8223.2 680.4 686.3 687.9 689.8 694.5 3666.0 3745.6 4055.7 4243.7 4281.4 51982.7 52868.5 53968.2 54266.0 54340.7 43784.8 44520.3 44535.9 45821.8 47362.8 39685.4 40257.8 47180.5 48094.5 48200.0 7923.2 7999.3 8056.0 8071.5 8216.6 33280.3 34882.0 34895.4 35185.6 35469.1 38683.6 39784.2 40844.8 40911.2 42582.8 10902.7 10932.5 11094.4 11117.3 11191.3 11548.2 11594.4 11748.2 11801.6 12201.8 11093.7 11159.2 11162.5 11165.9 11172.9 10499.9 10545.3 10564.3 10584.2 10594.8 11070.8 11070.9 11107.7 11159.7 11187.3 8640.5 8927.5 8999.5 9120.6 9164.0 8628.8 8663.4 9111.5 9179.3 9263.9 23:21:04 INFO - PROCESS | 18630 | -------- Summary: end -------- 23:21:04 INFO - PROCESS | 18630 | 23:21:05 INFO - TEST-INFO | 18630: exit 0 23:21:05 INFO - TEST-OK | dromaeo_css | took 1113221ms 23:21:05 INFO - TEST-START | kraken 23:21:05 INFO - operating with platform_type : linux_ 23:21:05 INFO - Initialising browser for kraken test... 23:21:05 INFO - TEST-INFO | started process 18823 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ42QiV/profile http://localhost:48958/getInfo.html) 23:21:10 INFO - PROCESS | 18823 | __metrics Screen width/height:1600/1200 23:21:10 INFO - PROCESS | 18823 | colorDepth:24 23:21:10 INFO - PROCESS | 18823 | Browser inner width/height: 1024/697 23:21:10 INFO - PROCESS | 18823 | __metrics 23:21:10 INFO - PROCESS | 18823 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:21:10 INFO - PROCESS | 18823 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:21:11 INFO - TEST-INFO | 18823: exit 0 23:21:11 INFO - Browser initialized. 23:21:11 INFO - Running cycle 1/1 for kraken test... 23:21:11 INFO - TEST-INFO | started process 18907 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpJ42QiV/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:21:22 INFO - PROCESS | 18907 | RSS: Main: 150380544 23:21:22 INFO - PROCESS | 18907 | 23:21:25 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48958/tests/kraken/driver.html?testName=audio-beat-detection) 23:21:26 INFO - PROCESS | 18907 | RSS: Main: 183615488 23:21:26 INFO - PROCESS | 18907 | 23:21:28 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48958/tests/kraken/driver.html?testName=audio-dft) 23:21:29 INFO - PROCESS | 18907 | RSS: Main: 176078848 23:21:29 INFO - PROCESS | 18907 | 23:21:32 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48958/tests/kraken/driver.html?testName=audio-fft) 23:21:32 INFO - PROCESS | 18907 | RSS: Main: 160833536 23:21:32 INFO - PROCESS | 18907 | 23:21:34 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48958/tests/kraken/driver.html?testName=audio-oscillator) 23:21:35 INFO - PROCESS | 18907 | RSS: Main: 162123776 23:21:35 INFO - PROCESS | 18907 | 23:21:37 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48958/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:21:38 INFO - PROCESS | 18907 | RSS: Main: 164569088 23:21:38 INFO - PROCESS | 18907 | 23:21:40 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48958/tests/kraken/driver.html?testName=imaging-darkroom) 23:21:41 INFO - PROCESS | 18907 | RSS: Main: 165560320 23:21:41 INFO - PROCESS | 18907 | 23:21:44 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48958/tests/kraken/driver.html?testName=imaging-desaturate) 23:21:45 INFO - PROCESS | 18907 | RSS: Main: 164368384 23:21:45 INFO - PROCESS | 18907 | 23:21:48 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48958/tests/kraken/driver.html?testName=json-parse-financial) 23:21:48 INFO - PROCESS | 18907 | RSS: Main: 164933632 23:21:48 INFO - PROCESS | 18907 | 23:21:50 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48958/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:21:50 INFO - PROCESS | 18907 | RSS: Main: 174432256 23:21:50 INFO - PROCESS | 18907 | 23:21:52 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48958/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:21:53 INFO - PROCESS | 18907 | RSS: Main: 172326912 23:21:53 INFO - PROCESS | 18907 | 23:21:55 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48958/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:21:55 INFO - PROCESS | 18907 | RSS: Main: 180686848 23:21:55 INFO - PROCESS | 18907 | 23:21:58 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:21:58 INFO - PROCESS | 18907 | RSS: Main: 186216448 23:21:58 INFO - PROCESS | 18907 | 23:22:01 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:22:02 INFO - PROCESS | 18907 | RSS: Main: 182800384 23:22:02 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | Cycle 1(1): loaded http://localhost:48958/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48958/tests/kraken/driver.html?testName=ai-astar) 23:22:03 INFO - PROCESS | 18907 | RSS: Main: 241848320 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | __start_tp_report 23:22:03 INFO - PROCESS | 18907 | _x_x_mozilla_page_load 23:22:03 INFO - PROCESS | 18907 | _x_x_mozilla_page_load_details 23:22:03 INFO - PROCESS | 18907 | |i|pagename|runs| 23:22:03 INFO - PROCESS | 18907 | |0;ai-astar;111;113;105;110;113;112;101;111;109;110 23:22:03 INFO - PROCESS | 18907 | |1;audio-beat-detection;156;124;151;161;128;155;158;124;168;126 23:22:03 INFO - PROCESS | 18907 | |2;audio-dft;160;161;161;162;163;161;159;164;161;161 23:22:03 INFO - PROCESS | 18907 | |3;audio-fft;72;71;85;90;70;74;74;114;94;72 23:22:03 INFO - PROCESS | 18907 | |4;audio-oscillator;96;97;150;96;97;96;139;96;96;142 23:22:03 INFO - PROCESS | 18907 | |5;imaging-gaussian-blur;110;110;109;110;109;110;109;109;110;109 23:22:03 INFO - PROCESS | 18907 | |6;imaging-darkroom;145;146;145;145;145;145;145;145;145;145 23:22:03 INFO - PROCESS | 18907 | |7;imaging-desaturate;96;96;96;95;96;95;96;96;96;96 23:22:03 INFO - PROCESS | 18907 | |8;json-parse-financial;57;58;58;57;58;58;66;67;54;57 23:22:03 INFO - PROCESS | 18907 | |9;json-stringify-tinderbox;68;67;67;67;67;68;68;68;69;67 23:22:03 INFO - PROCESS | 18907 | |10;stanford-crypto-aes;83;94;84;85;85;88;85;85;86;93 23:22:03 INFO - PROCESS | 18907 | |11;stanford-crypto-ccm;119;114;122;121;123;122;116;117;115;122 23:22:03 INFO - PROCESS | 18907 | |12;stanford-crypto-pbkdf2;141;139;150;154;156;139;151;141;150;138 23:22:03 INFO - PROCESS | 18907 | |13;stanford-crypto-sha256-iterative;67;67;68;68;67;68;68;68;68;70 23:22:03 INFO - PROCESS | 18907 | __end_tp_report 23:22:03 INFO - PROCESS | 18907 | __start_cc_report 23:22:03 INFO - PROCESS | 18907 | _x_x_mozilla_cycle_collect,942 23:22:03 INFO - PROCESS | 18907 | __end_cc_report 23:22:03 INFO - PROCESS | 18907 | __startTimestamp1451892123937__endTimestamp 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | ------- Summary: start ------- 23:22:03 INFO - PROCESS | 18907 | Number of tests: 14 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#0] ai-astar Cycles:10 Average:109.50 Median:111.00 stddev:3.78 (3.4%) stddev-sans-first:3.97 23:22:03 INFO - PROCESS | 18907 | Values: 111.0 113.0 105.0 110.0 113.0 112.0 101.0 111.0 109.0 110.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:155.50 stddev:17.46 (11.2%) stddev-sans-first:18.07 23:22:03 INFO - PROCESS | 18907 | Values: 156.0 124.0 151.0 161.0 128.0 155.0 158.0 124.0 168.0 126.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:1.42 (0.9%) stddev-sans-first:1.42 23:22:03 INFO - PROCESS | 18907 | Values: 160.0 161.0 161.0 162.0 163.0 161.0 159.0 164.0 161.0 161.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#3] audio-fft Cycles:10 Average:81.60 Median:74.00 stddev:14.27 (19.3%) stddev-sans-first:14.71 23:22:03 INFO - PROCESS | 18907 | Values: 72.0 71.0 85.0 90.0 70.0 74.0 74.0 114.0 94.0 72.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#4] audio-oscillator Cycles:10 Average:110.50 Median:96.00 stddev:23.05 (24.0%) stddev-sans-first:23.84 23:22:03 INFO - PROCESS | 18907 | Values: 96.0 97.0 150.0 96.0 97.0 96.0 139.0 96.0 96.0 142.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:22:03 INFO - PROCESS | 18907 | Values: 110.0 110.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#6] imaging-darkroom Cycles:10 Average:145.10 Median:145.00 stddev:0.32 (0.2%) stddev-sans-first:0.33 23:22:03 INFO - PROCESS | 18907 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 145.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 23:22:03 INFO - PROCESS | 18907 | Values: 96.0 96.0 96.0 95.0 96.0 95.0 96.0 96.0 96.0 96.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:58.00 stddev:4.14 (7.1%) stddev-sans-first:4.32 23:22:03 INFO - PROCESS | 18907 | Values: 57.0 58.0 58.0 57.0 58.0 58.0 66.0 67.0 54.0 57.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 23:22:03 INFO - PROCESS | 18907 | Values: 68.0 67.0 67.0 67.0 67.0 68.0 68.0 68.0 69.0 67.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#10] stanford-crypto-aes Cycles:10 Average:86.80 Median:85.50 stddev:3.77 (4.4%) stddev-sans-first:3.73 23:22:03 INFO - PROCESS | 18907 | Values: 83.0 94.0 84.0 85.0 85.0 88.0 85.0 85.0 86.0 93.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#11] stanford-crypto-ccm Cycles:10 Average:119.10 Median:121.50 stddev:3.35 (2.8%) stddev-sans-first:3.55 23:22:03 INFO - PROCESS | 18907 | Values: 119.0 114.0 122.0 121.0 123.0 122.0 116.0 117.0 115.0 122.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.90 Median:150.00 stddev:6.94 (4.6%) stddev-sans-first:7.13 23:22:03 INFO - PROCESS | 18907 | Values: 141.0 139.0 150.0 154.0 156.0 139.0 151.0 141.0 150.0 138.0 23:22:03 INFO - PROCESS | 18907 | 23:22:03 INFO - PROCESS | 18907 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 23:22:03 INFO - PROCESS | 18907 | Values: 67.0 67.0 68.0 68.0 67.0 68.0 68.0 68.0 68.0 70.0 23:22:03 INFO - PROCESS | 18907 | -------- Summary: end -------- 23:22:03 INFO - PROCESS | 18907 | 23:22:04 INFO - TEST-INFO | 18907: exit 0 23:22:04 INFO - TEST-OK | kraken | took 59230ms 23:22:04 INFO - TEST-START | v8_7 23:22:04 INFO - operating with platform_type : linux_ 23:22:04 INFO - Initialising browser for v8_7 test... 23:22:04 INFO - TEST-INFO | started process 19159 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIVJdZS/profile http://localhost:48958/getInfo.html) 23:22:09 INFO - PROCESS | 19159 | __metrics Screen width/height:1600/1200 23:22:09 INFO - PROCESS | 19159 | colorDepth:24 23:22:09 INFO - PROCESS | 19159 | Browser inner width/height: 1024/697 23:22:09 INFO - PROCESS | 19159 | __metrics 23:22:09 INFO - PROCESS | 19159 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:22:09 INFO - PROCESS | 19159 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:22:10 INFO - TEST-INFO | 19159: exit 0 23:22:10 INFO - Browser initialized. 23:22:10 INFO - Running cycle 1/1 for v8_7 test... 23:22:10 INFO - TEST-INFO | started process 19245 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpIVJdZS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:22:22 INFO - PROCESS | 19245 | RSS: Main: 149467136 23:22:22 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | Cycle 1(1): loaded http://localhost:48958/tests/v8_7/run.html (next: http://localhost:48958/tests/v8_7/run.html) 23:22:43 INFO - PROCESS | 19245 | RSS: Main: 547463168 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | __start_tp_report 23:22:43 INFO - PROCESS | 19245 | _x_x_mozilla_page_load 23:22:43 INFO - PROCESS | 19245 | _x_x_mozilla_page_load_details 23:22:43 INFO - PROCESS | 19245 | |i|pagename|runs| 23:22:43 INFO - PROCESS | 19245 | |0;Richards;167.95431642593215 23:22:43 INFO - PROCESS | 19245 | |1;DeltaBlue;190.76688286913392 23:22:43 INFO - PROCESS | 19245 | |2;Encrypt;281.37310073157005 23:22:43 INFO - PROCESS | 19245 | |3;Decrypt;5263.1578947368425 23:22:43 INFO - PROCESS | 19245 | |4;RayTrace;1112.2222222222222 23:22:43 INFO - PROCESS | 19245 | |5;Earley;796.8127490039841 23:22:43 INFO - PROCESS | 19245 | |6;Boyer;12530.864197530864 23:22:43 INFO - PROCESS | 19245 | |7;RegExp;26128.20512820513 23:22:43 INFO - PROCESS | 19245 | |8;Splay;594.5303210463734 23:22:43 INFO - PROCESS | 19245 | |9;NavierStokes;4835.748792270531 23:22:43 INFO - PROCESS | 19245 | __end_tp_report 23:22:43 INFO - PROCESS | 19245 | __startTimestamp1451892163854__endTimestamp 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | ------- Summary: start ------- 23:22:43 INFO - PROCESS | 19245 | Number of tests: 10 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#0] Richards Cycles:1 Average:167.95 Median:167.95 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 168.0 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#1] DeltaBlue Cycles:1 Average:190.77 Median:190.77 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 190.8 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 281.4 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#3] Decrypt Cycles:1 Average:5263.16 Median:5263.16 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 5263.2 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#4] RayTrace Cycles:1 Average:1112.22 Median:1112.22 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 1112.2 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 796.8 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#6] Boyer Cycles:1 Average:12530.86 Median:12530.86 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 12530.9 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#7] RegExp Cycles:1 Average:26128.21 Median:26128.21 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 26128.2 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#8] Splay Cycles:1 Average:594.53 Median:594.53 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 594.5 23:22:43 INFO - PROCESS | 19245 | 23:22:43 INFO - PROCESS | 19245 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 23:22:43 INFO - PROCESS | 19245 | Values: 4835.7 23:22:43 INFO - PROCESS | 19245 | -------- Summary: end -------- 23:22:43 INFO - PROCESS | 19245 | 23:22:44 INFO - TEST-INFO | 19245: exit 0 23:22:44 INFO - TEST-OK | v8_7 | took 39808ms 23:22:44 INFO - SUITE-END | took 1212s 23:22:44 INFO - Completed test suite (00:20:12) 23:22:44 INFO - Working with test: dromaeo_css 23:22:44 INFO - Generating results file: dromaeo_css 23:22:44 INFO - Working with test: kraken 23:22:44 INFO - Generating results file: kraken 23:22:44 INFO - javascript benchmark 23:22:44 INFO - Working with test: v8_7 23:22:44 INFO - Generating results file: v8_7 23:22:44 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:22:44 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:22:44 INFO - process_Request line: dromaeo_css 6685.75 graph.html#tests=[[72,201,35]] 23:22:44 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:22:44 INFO - process_Request line: kraken 1504.70 graph.html#tests=[[232,201,35]] 23:22:44 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:22:44 INFO - process_Request line: v8_7 20880.66 graph.html#tests=[[230,201,35]] 23:22:44 INFO - RETURN: dromaeo_css: 6685.75 23:22:44 INFO - RETURN: kraken: 1504.70 23:22:44 INFO - RETURN: v8_7: 20880.66 23:22:44 INFO - javascript benchmark 23:22:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3128.7340576051065, 3134.091113577063, 3216.6461689214198, 3223.355328934214, 3245.3996010738024, 5036.194208926572, 5095.108356037693, 5144.819931302405, 5184.481551844814, 5219.42586315505, 5148.845534633958, 5193.428722840485, 5226.4512226216175, 5263.0526505229045, 5263.49996750309, 4680.78936447859, 4710.952890471094, 4731.952680473186, 4738.076075165344, 4813.181759100961, 4867.075255701423, 4881.804727810883, 4886.755662216893, 4896.534829191239, 4939.357883475143, 4619.930701039487, 4674.111918735463, 4734.83428080019, 4755.35802666639, 4797.040591881603, 4806.4712881583, 4817.891884866465, 4820.68665536739, 4828.710277383333, 4857.878553036202, 4791.5687588117235, 4796.5203479651755, 4797.784099715521, 4810.711357318537, 4825.662203645747, 4920.926186107211, 5013.849584512471, 5031.496850314976, 5117.385913690381, 5129.538341549279, 5505.898820235929, 5543.390227075019, 5548.223248745179, 5554.750036248338, 5557.943990641806, 5480.479354461319, 5550.389457159749, 5562.0, 5570.721463926788, 5582.553395728332, 5154.92267615986, 5202.843914682528, 5237.214417837355, 5255.921161182585, 5270.077736396153, 5581.972090139523, 5612.326520817528, 5623.268975033219, 5636.85907852307, 5685.658860468385, 5236.136037553837, 5348.973255133699, 5413.0, 5427.457254274541, 5457.263269458573, 5436.700981446058, 5535.612507124543, 5610.971945140248, 5631.690257035821, 5672.574556908248, 5488.286522752017, 5506.91739623906, 5511.944880551223, 5521.365043020104, 5523.585731070186, 5520.392756796749, 5520.66875987434, 5524.558035357242, 5529.751161197756, 5529.944700552943, 4056.3104272273786, 4083.9795801020805, 4129.070959034193, 4160.625543701081, 4175.164967006611, 3811.27585758705, 3821.0256384621744, 3826.4642949987024, 3860.8069596520622, 3864.8067596620617, 5247.737613119329, 5265.078611243017, 5273.815416460406, 5282.867928301823, 5288.576913846883, 5386.380566234855, 5476.91784623231, 5477.287952566141, 5479.75341109651, 5561.972190139104, 5227.817026404057, 5230.843074707689, 5231.136862417658, 5281.419043905167, 5287.048331300326, 4627.028324051919, 4629.976850115728, 4631.652626053059, 4666.650001249852, 4676.462206846256, 5624.465675760878, 5734.197212390352, 5770.163326317745, 5790.536757059425, 5792.536597072309, 5337.439568845371, 5446.346438427414, 5468.808591699271, 5529.502344788988, 5538.030844602259, 5715.599908006399, 5716.79991200306, 5718.513926316144, 5723.112917497794, 5758.107493338539, 5366.543843773323, 5416.458354164552, 5417.918731218956, 5432.837014889559, 5433.728313584384, 5379.327584051994, 5480.3971563128825, 5536.169574563848, 5548.3619383769765, 5558.861028474321, 5389.649672771257, 5391.487808658171, 5392.299001129828, 5393.083175860034, 5398.0, 5370.436104209002, 5379.354477462573, 5392.191171324333, 5402.216678581663, 5451.863703407288, 5221.086309895829, 5289.894202115859, 5323.0950738373795, 5329.973350133225, 5390.892182156414, 5405.405405405481, 5424.810131645373, 5426.810061647823, 5432.456754324536, 5473.28847249855, 5080.695158290514, 5314.070037743457, 5314.8937021260135, 5316.282301889196, 5319.361676598833], "unit": "score", "name": "dojo.html", "value": 5109.516098439856}, {"lowerIsBetter": false, "replicates": [522.8405336372405, 529.1586377659521, 536.8013834881094, 553.3138907754386, 557.5595279729014, 27866.16401507953, 28392.0, 28419.715802841965, 28476.43047139056, 35947.64052359475, 38914.8054259729, 39407.605923940755, 39512.802435987855, 39693.80153099238, 39797.60202397975, 8306.75079747607, 8477.152284771504, 8478.321734261275, 8479.19447652472, 8481.491110533389, 7440.0, 7576.0908690956885, 9825.213982881352, 9972.850407243897, 10009.649662261822, 9829.262805289596, 9909.752256193617, 9912.801743965116, 9921.652742154027, 9943.602255909755, 7551.509151905108, 7706.884396734054, 9610.615575376976, 9776.95111524445, 9786.804263914717, 9819.803603927952, 9952.651657191964, 10018.09837114656, 10027.89972100277, 10050.346727462691, 35534.64465355365, 35748.64251357479, 36021.459678104846, 36113.63886361155, 36188.27623447542, 3188.537662038991, 3225.854836532362, 3298.752593555469, 3332.2002719347183, 3609.404448266033, 27459.17622471329, 27688.723112769017, 27788.95373155119, 28980.130596082152, 29988.8500557498, 3478.739094567892, 3611.56661200655, 3637.1270894985278, 3642.0894776305922, 3669.94495082574, 274633.0, 275421.0, 276317.0, 276526.0, 276767.0, 49962.0, 50973.490265097615, 58478.70760646254, 58564.0, 59807.700961495786, 53095.73452132715, 53129.734351328, 53387.46612533903, 53692.19461708077, 53717.73141134269, 14178.787318190236, 14239.92880035614, 14254.144751314954, 14266.429342826379, 14285.0, 10948.671539853816, 11001.449927503752, 11082.0, 11085.944570277097, 11229.606963756229, 18982.33561825357, 19332.226710931685, 19624.21503139887, 19671.803281967284, 19726.210951561778, 7103.538270012433, 7185.640717964081, 7233.963830180815, 7293.52592081513, 7319.743808966767, 803.7026300268938, 888.9777755556163, 909.8726178335038, 991.2020823237219, 1011.2718842433436, 25349.74650253511, 25989.0, 27160.45679086407, 27228.727712723015, 30028.24929376783, 914.1818072824917, 925.4678559828126, 939.5349302095507, 946.2099147212155, 955.7658373698488, 15771.211439427983, 16271.183059537112, 16295.837041629431, 16812.74780878288, 16903.408380706616, 373899.0, 380403.0, 382240.0, 382794.0, 382986.0, 52669.736651316496, 53209.733951329996, 53279.73360133252, 54787.45212547903, 54892.0, 1099.2360309584922, 1333.2667033131934, 1340.684939039325, 1365.1672479787321, 1374.2785037855206, 22351.552968940206, 27442.725572744017, 28179.295517612223, 29395.0, 30058.54912176363, 44534.331985019606, 45065.32402014038, 45169.77415112904, 45203.77398112988, 45328.0, 290570.0, 295480.0, 295699.0, 301516.0, 429383.0, 41055.689152638544, 41986.0, 42044.79552044893, 42094.36858447187, 42819.14361712811, 44649.0, 45284.54715452803, 45297.32054019258, 45324.32013519866, 45692.314615280135, 37221.0, 38226.426603601525, 38451.615483845926, 38608.61391386163, 40010.0, 38305.18888492426, 38340.80829595834, 39482.80258598689, 39512.20975580415, 39767.0, 36719.41007374078, 36952.44571331486, 37107.25785484221, 37616.24767504689, 38018.619813802616, 32817.34365312633, 34936.0, 35090.0, 35422.645773542965, 35457.82271088628, 23940.88029559841, 24631.0, 25142.74857251404, 25355.0, 25477.0], "unit": "score", "name": "ext.html", "value": 18421.62542723523}, {"lowerIsBetter": false, "replicates": [339.3941813862256, 344.8241396887588, 347.2343482620821, 348.6983759048424, 353.92036791721864, 13938.651533711662, 14417.134971901693, 16071.116088615136, 16230.675386492278, 16963.575910602256, 14548.781768273484, 14585.34365953532, 14676.412943482248, 14689.118652880834, 14730.18983955882, 5248.317718696583, 5262.578993680516, 5340.412554618989, 5344.385395679507, 5351.224072509483, 4072.572379900112, 4198.6850986176005, 5301.840944771663, 5770.711464426783, 5929.792457263975, 5886.793962211324, 5890.676012819315, 5912.9113063304085, 5930.199423077894, 5943.078822782476, 5745.597808153431, 5850.6782126983, 5851.385604511529, 5851.38560451155, 5860.794872179475, 5114.590832733373, 5125.3080834087295, 5136.075506408845, 5136.845894623168, 5149.6910185389, 11992.64022079339, 12296.139270251086, 12323.876761232363, 12347.38263086842, 18148.364807231683, 2025.7771645119026, 2091.6757902525133, 2108.947276318089, 2122.724045874042, 2166.750823655284, 8810.339224558184, 8885.378023538355, 8900.109989001114, 8942.68700595476, 9118.316126290554, 1638.2873450049267, 1645.539249010279, 1662.7672125902384, 1668.382698401599, 1698.3376483171573, 60719.69640151771, 62267.7546449073, 62808.37191628071, 63653.68173159151, 63856.68071659612, 10078.193744500422, 10102.898971010343, 10108.0, 10138.695839124837, 10226.897731022744, 13285.601431957057, 13307.0, 13309.40107695156, 13310.866891331156, 13316.6670833228, 7199.77603807354, 7207.92792072083, 7232.638368081575, 7254.492185546961, 7367.631618419057, 6697.296783837724, 6708.597484150967, 6717.496187785936, 6793.320667933266, 6826.93173068263, 4371.191329604034, 4444.200043992112, 4450.1989641864775, 4468.396766436555, 4480.574345437243, 1714.5113642611796, 1767.328415202215, 1776.3338747969512, 1817.963640727178, 1838.3106335124328, 389.2642904909723, 393.7519362801474, 408.6669364467949, 726.3862036579083, 771.124773382204, 9955.352902061342, 10277.691669249934, 10289.3311934724, 10317.27779055474, 10615.31000484966, 417.6470882104617, 419.35419454040436, 431.11836294777254, 438.6074463355279, 439.969202155846, 5524.3370795504, 5713.628614140068, 5733.713314334266, 5758.107493338539, 6032.698365081728, 355541.0, 511756.0, 516205.0, 523987.0, 527448.0, 64413.35586644167, 72955.63522182356, 73717.0, 74740.62629686817, 75834.24165758272, 485.4368932038818, 498.3496537019152, 499.5928318420476, 500.5395036566368, 500.57201093065635, 8708.651653933772, 9712.75718107053, 9924.908260091528, 9990.850137247802, 10344.689659310232, 35856.0, 36817.815910920275, 36841.44737828881, 36982.8150859244, 37043.62956370402, 40566.0, 41468.0, 41830.0, 43476.0, 44713.55286447094, 9486.715398538056, 9778.168855647065, 10061.949690251502, 10065.899341006789, 10074.748131296483, 16634.0, 16955.745663815298, 17107.23017464192, 17476.73784893202, 17744.91127544354, 13072.607821764981, 13118.409671564994, 13182.868171318163, 13433.932830335785, 14004.579862604138, 11971.76056478883, 13910.860891391361, 14200.78698819498, 14548.199849008406, 15062.623434414227, 13362.799558006443, 14112.858871411154, 14204.218767967861, 14325.0, 14990.17554034495, 9015.772367450132, 9439.480828554495, 9478.431294122374, 9532.90467095348, 9542.761430964281, 9666.130048295687, 9733.659321923698, 10119.544620491948, 14553.272336382926, 14575.125492470486], "unit": "score", "name": "jquery.html", "value": 7727.726505602433}, {"lowerIsBetter": false, "replicates": [1264.096171237565, 1453.7237924794288, 1467.4203689542628, 1601.383467365064, 1742.8867123636962, 6898.413634841038, 7493.587852668101, 7623.199564045772, 7657.808554786133, 7659.655315510801, 7596.164421913585, 7786.065672119354, 7795.92204077959, 7802.0, 7802.960985195066, 1997.410763824668, 2038.4292398128548, 2042.4893776555862, 2228.8551244169075, 2248.269312473453, 2229.9108035678632, 2277.9886100569556, 2278.487340348425, 2279.566882292359, 2279.794818466338, 2218.456478162844, 2224.2326397392953, 2297.3337732057685, 2299.3446867642724, 2300.1029598456616, 2275.6814046033487, 2275.9317220483495, 2292.9197478088354, 2311.04091801902, 2320.4662927526597, 2235.5417139486367, 2246.7753224677563, 2261.2876943762826, 2262.1290803040783, 2268.194790849241, 7565.924340756577, 7581.431392645519, 7671.386289096915, 7677.654505547208, 7683.500572462772, 4716.646251531149, 4843.055604157191, 4845.152098382804, 4849.0, 4850.660453768238, 3081.6610172880964, 3107.8912238071784, 3110.5956225690516, 3110.6578276389578, 3234.36929798687, 1071.3518321415588, 1095.8246680531076, 1106.4523061084815, 1151.435796459737, 1162.3839365136491, 10499.475026248734, 10671.19966002553, 10688.091512221548, 10696.251262411633, 10723.302985306009, 4092.508898932147, 4107.712460127762, 4167.666586673059, 4258.403823464718, 4268.551802060739, 8638.913610863936, 8730.563471826383, 8731.956340218258, 8735.912640873637, 8738.344624153215, 4533.909321813545, 4557.339185818104, 4566.383538222364, 4566.680332376702, 4567.063751930847, 4130.91738165241, 4161.146964872194, 4170.457840480779, 4173.833046678099, 4173.979130104391, 3192.4892017277125, 3236.368908062905, 3354.26206234628, 3370.0732298618077, 3452.913677158091, 1055.9524821383056, 1066.1257768629805, 1076.4187338837096, 1077.3589714120087, 1084.143526613982, 1053.510117795229, 1054.6150655010865, 1107.5126944144552, 1163.4880652513036, 1264.6585421936027, 7133.322334378226, 7303.671334789948, 7383.07711536058, 7385.6307184640555, 7391.371733402613, 615.9414855588711, 619.9752009919642, 630.7445484578753, 635.3202073781102, 773.8431045586772, 5650.943490565124, 5783.363829978699, 5869.178315035899, 5881.882362352729, 5884.499817515473, 9363.719088427359, 9578.137967582812, 9593.904060959441, 9616.51917404141, 9630.133288004114, 8870.112988701207, 9001.18989290967, 9497.287703422133, 9507.239420846454, 9532.18976387001, 7313.0, 7376.262373762688, 7381.188069312371, 7429.07136607924, 7429.405647548183, 7261.891071633824, 7352.558846469229, 7399.963000184965, 7411.481196316422, 7412.777616671508, 7919.802004949923, 8265.421420500506, 8548.658053677784, 8759.03650598421, 8772.122787721177, 8223.301019413417, 8432.030316513434, 8433.704820331259, 8434.620442079999, 8615.526146062026, 6663.0, 6772.762953296611, 6773.966130169318, 6780.118584583973, 6783.084283621648, 7403.7408690695565, 7422.70309187648, 7427.368673662799, 7476.065491813523, 7595.5822429766895, 7012.298770122947, 7081.18566364854, 7109.502334836719, 7160.212376638461, 7302.853942921218, 7075.5047146699235, 7125.82185445368, 7212.098487689039, 7272.23641517633, 7357.374623157091, 7246.7101315946775, 7303.30618591233, 7304.342609165201, 7305.488615796843, 7314.634268286671, 6508.544401891822, 6617.900731488935, 6625.933740662532, 6635.502337324817, 6647.069410282467, 6669.4664426844765, 6727.192736871411, 6732.360425759545, 6736.090627765189, 6736.93263067363], "unit": "score", "name": "mootools.html", "value": 4404.000336374579}, {"lowerIsBetter": false, "replicates": [333.5597011944233, 334.7573009568063, 337.16887871397, 341.259466956704, 345.94464885618305, 5653.717314134287, 5786.276715410574, 5789.594728369016, 5802.41975802419, 5856.063029915214, 5638.097904335307, 5735.0, 5736.340320863092, 5745.138229265613, 5749.223854779603, 4522.389477420539, 4522.932156017662, 4530.116627257669, 4531.048479819242, 4531.252343363341, 4339.522652508222, 4397.890052748675, 4421.6683748718815, 4486.798094085758, 4509.77451127444, 4433.9113217735785, 4442.489113751912, 4467.441569803775, 4468.508464068966, 4473.776311184428, 4450.0, 4476.507584165755, 4477.171723231213, 4478.529754375792, 4480.820767169309, 3952.7430717003303, 3962.9603703963166, 3964.4846169998004, 3966.5835087315704, 3975.1652153047894, 5418.485243901823, 5535.418781027975, 5540.058190107691, 5566.081596536566, 5583.6928968906695, 5132.076226279269, 5133.948660513384, 5137.357830271216, 5138.460461651547, 5142.331496905415, 5806.158107074492, 6089.695515224221, 6094.451499365078, 6095.634261944253, 6099.176611157525, 4180.226658068236, 4196.118815048843, 4270.0, 4278.229918614648, 4278.871633850989, 6250.343713910065, 6327.17746692927, 6340.841478963017, 6349.428551430347, 6352.301246862888, 4382.320740285261, 4384.714993525411, 4386.1008493258805, 4386.605205531518, 4387.254166791653, 4296.656267498593, 4443.622292105208, 4444.622207112367, 4444.688871778944, 4448.666350023761, 5105.7191854448365, 5118.129917913963, 5118.129917913963, 5135.0, 5165.61257905651, 6117.235345581802, 6143.56995010345, 6145.170401995762, 6148.6925653717135, 6149.723262453201, 1550.046721266413, 1568.615689156164, 1569.4899157773768, 1570.3169121432213, 1570.46604154588, 1034.234666346898, 1045.341434896026, 1052.9789404211872, 1057.4765491081964, 1059.936403815758, 5806.361300256968, 5827.65034097947, 5850.531957443394, 5852.385499522574, 5857.297124345106, 6282.654454004982, 6308.053791931247, 6315.842103947438, 6323.462505687068, 6323.7786677466065, 5852.824415267549, 5865.0, 5872.354041055481, 5910.527157827363, 5911.704414779244, 3311.172206948263, 3407.5059116428474, 3410.3179364127272, 3413.197898493852, 3413.2832105258176, 6501.122348482989, 6543.607383556907, 6547.672616369163, 6551.868962620721, 6563.901541476882, 6419.871602567922, 6429.58207716497, 6433.581817181868, 6445.677716114175, 6460.3862633049785, 6382.20222472191, 6523.054157147092, 6536.477081833442, 6546.70539825709, 6547.770828021092, 6099.9390006099375, 6247.812565623039, 6267.5299352549655, 6285.528585356025, 6287.874242515216, 6138.969305153446, 6186.566940314135, 6237.033259844731, 6243.375662433902, 6286.277078136073, 6546.116274302908, 6580.440662543738, 6584.539082264387, 6607.405333519814, 6612.173478315211, 4312.827486900489, 4397.406350142818, 4401.251787196248, 4411.029573493826, 4411.139827733561, 6353.110564520878, 6355.459785918249, 6361.968190159019, 6372.9362706374195, 6373.681315934092, 6180.7527698891545, 6181.227346581677, 6182.938170618416, 6184.134221208944, 6186.257649082139, 6026.156338112755, 6230.408111229426, 6255.655938923403, 6258.718357674006, 6261.718222680081, 6067.817965461043, 6072.787452439144, 6079.969600151971, 6081.1486391906055, 6081.27024757032, 6200.720967556561, 6208.875822483616, 6209.565330426827, 6212.068189771389, 6216.72024758896, 5950.761969521171, 6073.089036644538, 6075.878482430415, 6077.0, 6079.179310792986], "unit": "score", "name": "prototype.html", "value": 4645.721578594822}, {"lowerIsBetter": false, "replicates": [731.4002517935293, 807.3742849291798, 810.4165001199142, 839.1692224697551, 858.0261403307246, 13724.725505489885, 13898.51355202568, 13916.234607096605, 13931.09447885888, 13945.442182312709, 12254.203476774004, 12371.69070773231, 12613.369331533433, 13106.213627182351, 13285.33573321335, 750.7822731407886, 753.0473950452682, 754.2156157596094, 758.8368500772333, 773.6711897443564, 758.6055251269337, 758.9905425783722, 763.6334559411486, 766.1954947305335, 807.1202389395557, 778.1012930065783, 826.4958375391006, 832.7501749475164, 843.3421930893912, 846.318713435684, 789.9690903371098, 793.309820456201, 795.9880601790978, 796.5220867479524, 797.2665148063795, 578.0808514461984, 607.7720854679495, 614.6987975891825, 615.003694015693, 616.1927874484395, 12095.213811102338, 12137.514499420013, 12154.696132596668, 12156.756864862742, 12224.511019559208, 10021.24840636948, 10058.295919285652, 10248.846267305997, 10671.626493072705, 10762.0, 9462.90537094634, 9526.333156679035, 9534.809303813954, 9721.076497732704, 9789.608415663364, 3359.5800524934384, 3410.1474631342167, 3425.2293234022145, 3425.400554902907, 3429.691327780487, 40619.7969010156, 41992.79003604963, 42133.0, 42221.78889105566, 46107.538924611, 9539.236861051098, 9543.713688589354, 9598.760030999281, 9770.951145244371, 9894.950525247328, 17421.04184269852, 17470.912645436692, 17498.12509374526, 17503.212355444037, 17512.0, 6171.228596425447, 6784.423324017415, 7218.314260145278, 7683.0780306363595, 7849.882251766228, 4050.4531888194715, 4133.607307305801, 4147.8963025924595, 4178.6657067434535, 4230.344296634026, 2991.9102426927225, 3011.1869795155185, 3015.381846721417, 3030.696930306996, 3031.1512776422637, 493.23302264978304, 499.6302735975352, 500.27709959109467, 510.6272421132594, 517.2551525802832, 582.1878479521044, 604.091527815036, 617.3301967365459, 630.1996464490072, 684.6200358800813, 7829.804254893673, 7860.292573668397, 7966.880496792553, 8143.104258531557, 8223.21879421454, 680.4012469027224, 686.3411125319649, 687.924328323884, 689.8309914070984, 694.4826104552141, 3665.9633403666157, 3745.550533935945, 4055.6679909052414, 4243.724157929724, 4281.357796330513, 51982.74008629932, 52868.471315287126, 53968.190477142874, 54266.0, 54340.72829635826, 43784.78107609441, 44520.3321950171, 44535.886602834544, 45821.770891146, 47362.76318618454, 39685.40471892924, 40257.79871100684, 47180.5281947183, 48094.5190548097, 48200.03599927982, 7923.20767923203, 7999.320057795153, 8055.959720201361, 8071.515709057476, 8216.589170541329, 33280.33439331152, 34882.0, 34895.41990792201, 35185.648143518236, 35469.11327216737, 38683.61316386913, 39784.20431591294, 40844.79577602093, 40911.1817763649, 42582.787086064374, 10902.727431814268, 10932.453377331261, 11094.445277736242, 11117.332960022424, 11191.2725672831, 11548.249363791327, 11594.362310072689, 11748.236364636272, 11801.645950621494, 12201.755964880831, 11093.667189984313, 11159.163062770487, 11162.49768760424, 11165.944170279097, 11172.888271117185, 10499.94750026245, 10545.31455455393, 10564.26050176511, 10584.206184536037, 10594.788104238027, 11070.833937491105, 11070.889291106985, 11107.666769996913, 11159.72100697489, 11187.272827266203, 8640.524771137647, 8927.464352138892, 8999.505027223566, 9120.589573469342, 9164.037776033421, 8628.78428039304, 8663.393562450568, 9111.544422778701, 9179.265658747418, 9263.907360926305], "unit": "score", "name": "yui.html", "value": 6000.698607954077}], "name": "dromaeo_css", "value": 6685.751240165788}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 105.0, 110.0, 113.0, 112.0, 101.0, 111.0, 109.0, 110.0], "unit": "score", "name": "ai-astar", "value": 109.5}, {"lowerIsBetter": true, "replicates": [156.0, 124.0, 151.0, 161.0, 128.0, 155.0, 158.0, 124.0, 168.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 145.1}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 162.0, 163.0, 161.0, 159.0, 164.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 85.0, 90.0, 70.0, 74.0, 74.0, 114.0, 94.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.6}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 150.0, 96.0, 97.0, 96.0, 139.0, 96.0, 96.0, 142.0], "unit": "score", "name": "audio-oscillator", "value": 110.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [57.0, 58.0, 58.0, 57.0, 58.0, 58.0, 66.0, 67.0, 54.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 59.0}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 68.0, 68.0, 68.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.6}, {"lowerIsBetter": true, "replicates": [83.0, 94.0, 84.0, 85.0, 85.0, 88.0, 85.0, 85.0, 86.0, 93.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.8}, {"lowerIsBetter": true, "replicates": [119.0, 114.0, 122.0, 121.0, 123.0, 122.0, 116.0, 117.0, 115.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.1}, {"lowerIsBetter": true, "replicates": [141.0, 139.0, 150.0, 154.0, 156.0, 139.0, 151.0, 141.0, 150.0, 138.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 70.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.9}], "name": "kraken", "value": 1504.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.95431642593215], "unit": "score", "name": "Richards", "value": 210.18810800000006}, {"lowerIsBetter": false, "replicates": [190.76688286913392], "unit": "score", "name": "DeltaBlue", "value": 346.59055600000005}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5263.1578947368425], "unit": "score", "name": "Decrypt", "value": 50.57439}, {"lowerIsBetter": false, "replicates": [1112.2222222222222], "unit": "score", "name": "RayTrace", "value": 665.324775224775}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [12530.864197530864], "unit": "score", "name": "Boyer", "value": 53.185717241379315}, {"lowerIsBetter": false, "replicates": [26128.20512820513], "unit": "score", "name": "RegExp", "value": 34.86596172718352}, {"lowerIsBetter": false, "replicates": [594.5303210463734], "unit": "score", "name": "Splay", "value": 137.06786199999996}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 20880.664845498293}]} 23:22:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20880.66"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1504.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6685.75"}}} 23:22:45 INFO - Return code: 0 23:22:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:22:45 INFO - # TBPL SUCCESS # 23:22:45 INFO - Running post-action listener: _resource_record_post_action 23:22:45 INFO - Running post-run listener: _resource_record_post_run 23:22:46 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 8192; Write bytes: 570638336; Read time: 112; Write time: 430608 23:22:46 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 234950656; Read time: 0; Write time: 237844 23:22:46 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 8192; Write bytes: 319766528; Read time: 112; Write time: 173712 23:22:46 INFO - Running post-run listener: _upload_blobber_files 23:22:46 INFO - Blob upload gear active. 23:22:46 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:22:46 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 23:22:46 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:22:46 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:22:46 INFO - (blobuploader) - INFO - Open directory for files ... 23:22:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:22:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:22:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:22:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:22:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:22:47 INFO - (blobuploader) - INFO - Done attempting. 23:22:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:22:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:22:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:22:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:22:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:22:48 INFO - (blobuploader) - INFO - Done attempting. 23:22:48 INFO - (blobuploader) - INFO - Iteration through files over. 23:22:48 INFO - Return code: 0 23:22:48 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:22:48 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:22:48 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/51d61a30fcb97ffc3b1f34547e0a7a77da9c2f6a17a46fe43b85a5be5b44534f37da7a47e4057ddc5e214e126e1a686b3886416822b5d7344f30b937994fd280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ab981edbbbfcccbf7ba7a5b2fca2803224178ffe521e00c5e12a4d462328687f4ad8b524db39ad239b03b6591b06181f4b0f42778f398dfecf50decf964866e3"} 23:22:48 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:22:48 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:22:48 INFO - Contents: 23:22:48 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/51d61a30fcb97ffc3b1f34547e0a7a77da9c2f6a17a46fe43b85a5be5b44534f37da7a47e4057ddc5e214e126e1a686b3886416822b5d7344f30b937994fd280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ab981edbbbfcccbf7ba7a5b2fca2803224178ffe521e00c5e12a4d462328687f4ad8b524db39ad239b03b6591b06181f4b0f42778f398dfecf50decf964866e3"} 23:22:48 INFO - Copying logs to upload dir... 23:22:48 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1264.659372 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-01-03 23:22:48.122598) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-03 23:22:48.126643) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/51d61a30fcb97ffc3b1f34547e0a7a77da9c2f6a17a46fe43b85a5be5b44534f37da7a47e4057ddc5e214e126e1a686b3886416822b5d7344f30b937994fd280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ab981edbbbfcccbf7ba7a5b2fca2803224178ffe521e00c5e12a4d462328687f4ad8b524db39ad239b03b6591b06181f4b0f42778f398dfecf50decf964866e3"} build_url:https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/LlwiUCfFSSCx0hcXMA75Vg/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/51d61a30fcb97ffc3b1f34547e0a7a77da9c2f6a17a46fe43b85a5be5b44534f37da7a47e4057ddc5e214e126e1a686b3886416822b5d7344f30b937994fd280", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/ab981edbbbfcccbf7ba7a5b2fca2803224178ffe521e00c5e12a4d462328687f4ad8b524db39ad239b03b6591b06181f4b0f42778f398dfecf50decf964866e3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-03 23:22:48.154199) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:22:48.154752) ========= 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=b4e1481c633df10bed3f4cc0000001c7-1451890901.860749-703372055 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004501 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-03 23:22:48.236823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-03 23:22:48.237263) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-03 23:22:48.237635) ========= ========= Total master_lag: 0.25 =========