builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-007 starttime: 1452865205.71 results: success (0) buildid: 20160115023017 builduid: 054f65ed8392413baaf8e893d1af787e revision: b8a038770d4c3ac1c108e95da19867ad6fe96cbb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.707693) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.708114) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.708413) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006280 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.734143) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.734451) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.749828) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.750137) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004623 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.798638) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.798931) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.802380) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.802668) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-15 05:40:06-- 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% 83.8M=0s 2016-01-15 05:40:06 (83.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090005 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.905164) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.905473) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020377 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:05.954766) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-15 05:40:05.955114) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b8a038770d4c3ac1c108e95da19867ad6fe96cbb --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/fx-team --rev b8a038770d4c3ac1c108e95da19867ad6fe96cbb --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=b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-15 05:40:06,595 truncating revision to first 12 chars 2016-01-15 05:40:06,595 Setting DEBUG logging. 2016-01-15 05:40:06,596 attempt 1/10 2016-01-15 05:40:06,596 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b8a038770d4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-15 05:40:07,717 unpacking tar archive at: fx-team-b8a038770d4c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.468238 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-15 05:40:07.436060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:07.436378) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:07.447049) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:07.447330) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2016-01-15 05:40:07.447766) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-15 05:40:07.448119) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:40:08 INFO - MultiFileLogger online at 20160115 05:40:08 in /builds/slave/test-pgo 05:40:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:40:08 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:40:08 INFO - {'append_to_log': False, 05:40:08 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:40:08 INFO - 'blob_upload_branch': 'Fx-Team', 05:40:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:40:08 INFO - 'branch': 'Fx-Team', 05:40:08 INFO - 'buildbot_json_path': 'buildprops.json', 05:40:08 INFO - 'config_files': ('talos/linux_config.py',), 05:40:08 INFO - 'default_actions': ('clobber', 05:40:08 INFO - 'read-buildbot-config', 05:40:08 INFO - 'download-and-extract', 05:40:08 INFO - 'populate-webroot', 05:40:08 INFO - 'create-virtualenv', 05:40:08 INFO - 'install', 05:40:08 INFO - 'run-tests'), 05:40:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:40:08 INFO - 'download_minidump_stackwalk': True, 05:40:08 INFO - 'download_symbols': 'ondemand', 05:40:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:40:08 INFO - 'tooltool.py': '/tools/tooltool.py', 05:40:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:40:08 INFO - '/tools/misc-python/virtualenv.py')}, 05:40:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:40:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:40:08 INFO - 'installer_path': 'installer.exe', 05:40:08 INFO - 'log_level': 'info', 05:40:08 INFO - 'log_name': 'talos', 05:40:08 INFO - 'log_to_console': True, 05:40:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:40:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:40:08 INFO - 'opt_config_files': (), 05:40:08 INFO - 'pip_index': False, 05:40:08 INFO - 'sps_profile': False, 05:40:08 INFO - 'sps_profile_interval': 0, 05:40:08 INFO - 'suite': 'dromaeojs', 05:40:08 INFO - 'system_bits': '32', 05:40:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:40:08 INFO - 'title': 'talos-linux64-ix-007', 05:40:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:40:08 INFO - 'use_talos_json': True, 05:40:08 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:40:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:40:08 INFO - 'work_dir': 'build'} 05:40:08 INFO - ##### 05:40:08 INFO - ##### Running clobber step. 05:40:08 INFO - ##### 05:40:08 INFO - Running pre-action listener: _resource_record_pre_action 05:40:08 INFO - Running main action method: clobber 05:40:08 INFO - rmtree: /builds/slave/test-pgo/build 05:40:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:40:09 INFO - Running post-action listener: _resource_record_post_action 05:40:09 INFO - ##### 05:40:09 INFO - ##### Running read-buildbot-config step. 05:40:09 INFO - ##### 05:40:09 INFO - Running pre-action listener: _resource_record_pre_action 05:40:09 INFO - Running main action method: read_buildbot_config 05:40:09 INFO - Using buildbot properties: 05:40:09 INFO - { 05:40:09 INFO - "project": "", 05:40:09 INFO - "product": "firefox", 05:40:09 INFO - "script_repo_revision": "production", 05:40:09 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:40:09 INFO - "repository": "", 05:40:09 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:40:09 INFO - "buildid": "20160115023017", 05:40:09 INFO - "pgo_build": "True", 05:40:09 INFO - "basedir": "/builds/slave/test-pgo", 05:40:09 INFO - "buildnumber": 898, 05:40:09 INFO - "slavename": "talos-linux64-ix-007", 05:40:09 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:40:09 INFO - "platform": "ubuntu64_hw", 05:40:09 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:40:09 INFO - "branch": "fx-team", 05:40:09 INFO - "repo_path": "integration/fx-team", 05:40:09 INFO - "revision": "b8a038770d4c3ac1c108e95da19867ad6fe96cbb", 05:40:09 INFO - "stage_platform": "linux64-pgo", 05:40:09 INFO - "builduid": "054f65ed8392413baaf8e893d1af787e", 05:40:09 INFO - "slavebuilddir": "test" 05:40:09 INFO - } 05:40:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 05:40:09 INFO - Running post-action listener: _resource_record_post_action 05:40:09 INFO - ##### 05:40:09 INFO - ##### Running download-and-extract step. 05:40:09 INFO - ##### 05:40:09 INFO - Running pre-action listener: _resource_record_pre_action 05:40:09 INFO - Running main action method: download_and_extract 05:40:09 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:40: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')]} 05:40:09 INFO - https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:40:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/test_packages.json 05:40:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/test_packages.json 05:40:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:40:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:40:09 INFO - Downloaded 1448 bytes. 05:40:09 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:40:09 INFO - Using the following test package requirements: 05:40:09 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:09 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:40:09 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:40:09 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:09 INFO - u'jsshell-linux-x86_64.zip'], 05:40:09 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:40:09 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:09 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:40:09 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:40:09 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:40:09 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 05:40:09 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 05:40:09 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:40:09 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:40: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')]} 05:40:09 INFO - https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:40:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:40:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/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 05:40:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/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 05:40:12 INFO - Downloaded 22439459 bytes. 05:40:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:40:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:40:13 INFO - Return code: 0 05:40:13 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 05:40:13 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')]} 05:40:13 INFO - https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:40:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:40:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 05:40:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/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 05:40:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/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 05:40:15 INFO - Downloaded 22439459 bytes. 05:40:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:40:15 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:40:17 INFO - Return code: 0 05:40:17 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')]} 05:40:17 INFO - https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:40:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 05:40:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/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 05:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/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 05:40:19 INFO - Downloaded 11132144 bytes. 05:40:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:40:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:40:19 INFO - Return code: 0 05:40:19 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')]} 05:40:19 INFO - https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:40:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:40:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:40:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/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 05:40:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TFJpTB9YRAOCJCgIghZbAA/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 05:40:22 INFO - Downloaded 55872389 bytes. 05:40:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:40:22 INFO - mkdir: /builds/slave/test-pgo/properties 05:40:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:40:22 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:40:22 INFO - Contents: 05:40:22 INFO - build_url:https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 05:40:22 INFO - Running post-action listener: _resource_record_post_action 05:40:22 INFO - Running post-action listener: set_extra_try_arguments 05:40:22 INFO - ##### 05:40:22 INFO - ##### Running populate-webroot step. 05:40:22 INFO - ##### 05:40:22 INFO - Running pre-action listener: _resource_record_pre_action 05:40:22 INFO - Running main action method: populate_webroot 05:40:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:40:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:40:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:40:22 INFO - '--tppagecycles', 05:40:22 INFO - '7'], 05:40:22 INFO - 'tests': ['tsvgm']}}, 05:40:22 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:40:22 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:40:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:40:22 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:40:22 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:40:22 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:40:22 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:22 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:22 INFO - 'talos_options': ['--e10s'], 05:40:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:40:22 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:22 INFO - 'tests': ['damp', 'tps']}, 05:40:22 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:22 INFO - 'talos_options': ['--e10s'], 05:40:22 INFO - 'tests': ['damp', 'tps']}, 05:40:22 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:40:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:40:22 INFO - 'other': {'tests': ['a11yr', 05:40:22 INFO - 'ts_paint', 05:40:22 INFO - 'tpaint', 05:40:22 INFO - 'sessionrestore', 05:40:22 INFO - 'sessionrestore_no_auto_restore']}, 05:40:22 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:40:22 INFO - 'tests': ['a11yr', 05:40:22 INFO - 'ts_paint', 05:40:22 INFO - 'tpaint', 05:40:22 INFO - 'sessionrestore', 05:40:22 INFO - 'sessionrestore_no_auto_restore']}, 05:40:22 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:40:22 INFO - 'tests': ['a11yr', 05:40:22 INFO - 'ts_paint', 05:40:22 INFO - 'tpaint', 05:40:22 INFO - 'sessionrestore', 05:40:22 INFO - 'sessionrestore_no_auto_restore']}, 05:40:22 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:40:22 INFO - 'tests': ['a11yr', 05:40:22 INFO - 'ts_paint', 05:40:22 INFO - 'tpaint', 05:40:22 INFO - 'sessionrestore', 05:40:22 INFO - 'sessionrestore_no_auto_restore']}, 05:40:22 INFO - 'other_l64': {'tests': ['a11yr', 05:40:22 INFO - 'ts_paint', 05:40:22 INFO - 'tpaint', 05:40:22 INFO - 'sessionrestore', 05:40:22 INFO - 'sessionrestore_no_auto_restore']}, 05:40:22 INFO - 'other_nol64': {'tests': ['a11yr', 05:40:22 INFO - 'ts_paint', 05:40:22 INFO - 'tpaint', 05:40:22 INFO - 'sessionrestore', 05:40:22 INFO - 'sessionrestore_no_auto_restore']}, 05:40:22 INFO - 'svgr': {'tests': ['tsvgx', 05:40:22 INFO - 'tsvgr_opacity', 05:40:22 INFO - 'tart', 05:40:22 INFO - 'tscrollx', 05:40:22 INFO - 'cart']}, 05:40:22 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:40:22 INFO - 'tests': ['tsvgx', 05:40:22 INFO - 'tsvgr_opacity', 05:40:22 INFO - 'tart', 05:40:22 INFO - 'tscrollx', 05:40:22 INFO - 'cart']}, 05:40:22 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:22 INFO - 'tests': ['tp5o']}, 05:40:22 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:22 INFO - 'talos_options': ['--e10s'], 05:40:22 INFO - 'tests': ['tp5o']}, 05:40:22 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:22 INFO - 'talos_options': ['--xperf_path', 05:40:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:22 INFO - 'tests': ['tp5n']}, 05:40:22 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:40:22 INFO - 'talos_options': ['--e10s', 05:40:22 INFO - '--xperf_path', 05:40:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:40:22 INFO - 'tests': ['tp5n']}}, 05:40:22 INFO - 'talos.zip': {'path': '', 05:40:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:40:22 INFO - Running post-action listener: _resource_record_post_action 05:40:22 INFO - ##### 05:40:22 INFO - ##### Running create-virtualenv step. 05:40:22 INFO - ##### 05:40:22 INFO - Running pre-action listener: _resource_record_pre_action 05:40:22 INFO - Running main action method: create_virtualenv 05:40:22 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:40:22 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 05:40:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:40:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:40:22 INFO - Using real prefix '/usr' 05:40:22 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:40:22 INFO - Installing distribute.............................................................................................................................................................................................done. 05:40:24 INFO - Installing pip.................done. 05:40:24 INFO - Return code: 0 05:40:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:40:24 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')]} 05:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:24 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')]} 05:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:24 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 0x7fdffb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', '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 05:40:24 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 05:40:24 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 05:40:24 INFO - Using env: {'DISPLAY': ':0', 05:40:24 INFO - 'HOME': '/home/cltbld', 05:40:24 INFO - 'LANG': 'en_US.UTF-8', 05:40:24 INFO - 'LANGUAGE': 'en_US:en', 05:40:24 INFO - 'LOGNAME': 'cltbld', 05:40:24 INFO - 'MAIL': '/var/mail/cltbld', 05:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:24 INFO - 'MOZ_NO_REMOTE': '1', 05:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:24 INFO - 'NO_EM_RESTART': '1', 05:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:24 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:24 INFO - 'SHELL': '/bin/bash', 05:40:24 INFO - 'SHLVL': '1', 05:40:24 INFO - 'TERM': 'linux', 05:40:24 INFO - 'TMOUT': '86400', 05:40:24 INFO - 'USER': 'cltbld', 05:40:24 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:24 INFO - '_': '/tools/buildbot/bin/python'} 05:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:24 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 05:40:24 INFO - Cleaning up... 05:40:24 INFO - Return code: 0 05:40:24 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:40:24 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')]} 05:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:24 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')]} 05:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:24 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 0x7fdffb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', '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 05:40:24 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 05:40:24 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 05:40:24 INFO - Using env: {'DISPLAY': ':0', 05:40:24 INFO - 'HOME': '/home/cltbld', 05:40:24 INFO - 'LANG': 'en_US.UTF-8', 05:40:24 INFO - 'LANGUAGE': 'en_US:en', 05:40:24 INFO - 'LOGNAME': 'cltbld', 05:40:24 INFO - 'MAIL': '/var/mail/cltbld', 05:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:24 INFO - 'MOZ_NO_REMOTE': '1', 05:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:24 INFO - 'NO_EM_RESTART': '1', 05:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:24 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:24 INFO - 'SHELL': '/bin/bash', 05:40:24 INFO - 'SHLVL': '1', 05:40:24 INFO - 'TERM': 'linux', 05:40:24 INFO - 'TMOUT': '86400', 05:40:24 INFO - 'USER': 'cltbld', 05:40:24 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:24 INFO - '_': '/tools/buildbot/bin/python'} 05:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:25 INFO - Downloading/unpacking psutil>=0.7.1 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 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 05:40:25 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 05:40:26 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 05:40:26 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:40:26 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:40:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:26 INFO - Installing collected packages: psutil 05:40:26 INFO - Running setup.py install for psutil 05:40:26 INFO - building 'psutil._psutil_linux' extension 05:40:26 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 05:40:27 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 05:40:27 INFO - building 'psutil._psutil_posix' extension 05:40:27 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 05:40:27 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 05:40:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:40:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:40:27 INFO - Successfully installed psutil 05:40:27 INFO - Cleaning up... 05:40:27 INFO - Return code: 0 05:40:27 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:40:27 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')]} 05:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:27 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')]} 05:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:27 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 0x7fdffb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', '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 05:40:27 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 05:40:27 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 05:40:27 INFO - Using env: {'DISPLAY': ':0', 05:40:27 INFO - 'HOME': '/home/cltbld', 05:40:27 INFO - 'LANG': 'en_US.UTF-8', 05:40:27 INFO - 'LANGUAGE': 'en_US:en', 05:40:27 INFO - 'LOGNAME': 'cltbld', 05:40:27 INFO - 'MAIL': '/var/mail/cltbld', 05:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:27 INFO - 'MOZ_NO_REMOTE': '1', 05:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:27 INFO - 'NO_EM_RESTART': '1', 05:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:27 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:27 INFO - 'SHELL': '/bin/bash', 05:40:27 INFO - 'SHLVL': '1', 05:40:27 INFO - 'TERM': 'linux', 05:40:27 INFO - 'TMOUT': '86400', 05:40:27 INFO - 'USER': 'cltbld', 05:40:27 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:27 INFO - '_': '/tools/buildbot/bin/python'} 05:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:40:27 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 05:40:27 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 05:40:27 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 05:40:27 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 05:40:27 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 05:40:27 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 05:40:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:40:29 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:40:29 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:40:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:40:29 INFO - Installing collected packages: mozsystemmonitor 05:40:29 INFO - Running setup.py install for mozsystemmonitor 05:40:29 INFO - Successfully installed mozsystemmonitor 05:40:29 INFO - Cleaning up... 05:40:29 INFO - Return code: 0 05:40:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:29 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 0x7fdffb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', '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 05:40:29 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 05:40:29 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 05:40:29 INFO - Using env: {'DISPLAY': ':0', 05:40:29 INFO - 'HOME': '/home/cltbld', 05:40:29 INFO - 'LANG': 'en_US.UTF-8', 05:40:29 INFO - 'LANGUAGE': 'en_US:en', 05:40:29 INFO - 'LOGNAME': 'cltbld', 05:40:29 INFO - 'MAIL': '/var/mail/cltbld', 05:40:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:29 INFO - 'MOZ_NO_REMOTE': '1', 05:40:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:29 INFO - 'NO_EM_RESTART': '1', 05:40:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:29 INFO - 'SHELL': '/bin/bash', 05:40:29 INFO - 'SHLVL': '1', 05:40:29 INFO - 'TERM': 'linux', 05:40:29 INFO - 'TMOUT': '86400', 05:40:29 INFO - 'USER': 'cltbld', 05:40:29 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:40:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:29 INFO - '_': '/tools/buildbot/bin/python'} 05:40:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:29 INFO - Downloading/unpacking blobuploader==1.2.4 05:40:29 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 05:40:29 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 05:40:29 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 05:40:29 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 05:40:29 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 05:40:29 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 05:40:31 INFO - Downloading blobuploader-1.2.4.tar.gz 05:40:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:40:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:40:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:40:31 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 05:40:31 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 05:40:31 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 05:40:31 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 05:40:31 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 05:40:31 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 05:40:31 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:40:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:40:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:40:31 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 05:40:31 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 05:40:31 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 05:40:31 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 05:40:31 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 05:40:31 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 05:40:32 INFO - Downloading docopt-0.6.1.tar.gz 05:40:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:40:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:40:32 INFO - Installing collected packages: blobuploader, requests, docopt 05:40:32 INFO - Running setup.py install for blobuploader 05:40:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:40:32 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:40:32 INFO - Running setup.py install for requests 05:40:32 INFO - Running setup.py install for docopt 05:40:32 INFO - Successfully installed blobuploader requests docopt 05:40:32 INFO - Cleaning up... 05:40:32 INFO - Return code: 0 05:40:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:32 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')]} 05:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:32 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')]} 05:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:32 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 0x7fdffb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', '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 05:40:32 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 05:40:32 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 05:40:32 INFO - Using env: {'DISPLAY': ':0', 05:40:32 INFO - 'HOME': '/home/cltbld', 05:40:32 INFO - 'LANG': 'en_US.UTF-8', 05:40:32 INFO - 'LANGUAGE': 'en_US:en', 05:40:32 INFO - 'LOGNAME': 'cltbld', 05:40:32 INFO - 'MAIL': '/var/mail/cltbld', 05:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:32 INFO - 'MOZ_NO_REMOTE': '1', 05:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:32 INFO - 'NO_EM_RESTART': '1', 05:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:32 INFO - 'SHELL': '/bin/bash', 05:40:32 INFO - 'SHLVL': '1', 05:40:32 INFO - 'TERM': 'linux', 05:40:32 INFO - 'TMOUT': '86400', 05:40:32 INFO - 'USER': 'cltbld', 05:40:32 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:32 INFO - '_': '/tools/buildbot/bin/python'} 05:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:33 INFO - Running setup.py (path:/tmp/pip-w7Z5XK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:33 INFO - Running setup.py (path:/tmp/pip-xE5v_D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:33 INFO - Running setup.py (path:/tmp/pip-70jlY4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:33 INFO - Running setup.py (path:/tmp/pip-4vqi8X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:33 INFO - Running setup.py (path:/tmp/pip-um4jQ1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:33 INFO - Running setup.py (path:/tmp/pip-ICXoTb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:33 INFO - Running setup.py (path:/tmp/pip-YbrtTs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:33 INFO - Running setup.py (path:/tmp/pip-2zl0tx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:33 INFO - Running setup.py (path:/tmp/pip-W3v9g4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:33 INFO - Running setup.py (path:/tmp/pip-6LkBVA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:33 INFO - Running setup.py (path:/tmp/pip-G58jyZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:33 INFO - Running setup.py (path:/tmp/pip-wVLlWC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:33 INFO - Running setup.py (path:/tmp/pip-QSKQZg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:33 INFO - Running setup.py (path:/tmp/pip-xefb5V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:34 INFO - Running setup.py (path:/tmp/pip-diPrtX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:34 INFO - Running setup.py (path:/tmp/pip-8IFIwU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:34 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:34 INFO - Running setup.py (path:/tmp/pip-LQA7er-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:40:34 INFO - Running setup.py install for manifestparser 05:40:34 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:40:34 INFO - Running setup.py install for mozcrash 05:40:34 INFO - Running setup.py install for mozdebug 05:40:34 INFO - Running setup.py install for mozdevice 05:40:34 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:40:34 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:40:34 INFO - Running setup.py install for mozfile 05:40:34 INFO - Running setup.py install for mozhttpd 05:40:34 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:40:34 INFO - Running setup.py install for mozinfo 05:40:34 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:40:34 INFO - Running setup.py install for mozInstall 05:40:35 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Running setup.py install for mozleak 05:40:35 INFO - Running setup.py install for mozlog 05:40:35 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Running setup.py install for moznetwork 05:40:35 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Running setup.py install for mozprocess 05:40:35 INFO - Running setup.py install for mozprofile 05:40:35 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Running setup.py install for mozrunner 05:40:35 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:40:35 INFO - Running setup.py install for mozscreenshot 05:40:35 INFO - Running setup.py install for moztest 05:40:35 INFO - Running setup.py install for mozversion 05:40:36 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:40:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:40:36 INFO - Cleaning up... 05:40:36 INFO - Return code: 0 05:40:36 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:36 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')]} 05:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:36 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')]} 05:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:36 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 0x7fdffb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', '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 05:40:36 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 05:40:36 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 05:40:36 INFO - Using env: {'DISPLAY': ':0', 05:40:36 INFO - 'HOME': '/home/cltbld', 05:40:36 INFO - 'LANG': 'en_US.UTF-8', 05:40:36 INFO - 'LANGUAGE': 'en_US:en', 05:40:36 INFO - 'LOGNAME': 'cltbld', 05:40:36 INFO - 'MAIL': '/var/mail/cltbld', 05:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:36 INFO - 'MOZ_NO_REMOTE': '1', 05:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:36 INFO - 'NO_EM_RESTART': '1', 05:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:36 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:36 INFO - 'SHELL': '/bin/bash', 05:40:36 INFO - 'SHLVL': '1', 05:40:36 INFO - 'TERM': 'linux', 05:40:36 INFO - 'TMOUT': '86400', 05:40:36 INFO - 'USER': 'cltbld', 05:40:36 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:36 INFO - '_': '/tools/buildbot/bin/python'} 05:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:36 INFO - Running setup.py (path:/tmp/pip-ZctVBI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:40:36 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:36 INFO - Running setup.py (path:/tmp/pip-WElhEP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:40:36 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:36 INFO - Running setup.py (path:/tmp/pip-eRgRjU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:40:36 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:36 INFO - Running setup.py (path:/tmp/pip-9ElLoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:40:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:36 INFO - Running setup.py (path:/tmp/pip-vmVlLH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:40:36 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:36 INFO - Running setup.py (path:/tmp/pip-KsrMBt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:40:36 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:36 INFO - Running setup.py (path:/tmp/pip-PNoJRD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:40:36 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:36 INFO - Running setup.py (path:/tmp/pip-ntZn4K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:40:36 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:36 INFO - Running setup.py (path:/tmp/pip-ynlaFv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:40:36 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:36 INFO - Running setup.py (path:/tmp/pip-ak1iuZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:40:36 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)) 05:40:36 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:36 INFO - Running setup.py (path:/tmp/pip-0edV7x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:40:37 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)) 05:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:37 INFO - Running setup.py (path:/tmp/pip-FXkbaI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:40:37 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)) 05:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:37 INFO - Running setup.py (path:/tmp/pip-Q5a7fW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:40:37 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)) 05:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:37 INFO - Running setup.py (path:/tmp/pip-0oNuXR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:40:37 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)) 05:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:37 INFO - Running setup.py (path:/tmp/pip-Z30duJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:40:37 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)) 05:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:37 INFO - Running setup.py (path:/tmp/pip-1Ohc3V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:40:37 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)) 05:40:37 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:37 INFO - Running setup.py (path:/tmp/pip-yUxd6Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:40:37 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)) 05:40:37 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)) 05:40:37 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)) 05:40:37 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)) 05:40:37 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:37 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:40:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:40:37 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 05:40:37 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 05:40:37 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 05:40:37 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 05:40:37 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 05:40:37 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 05:40:39 INFO - Downloading blessings-1.5.1.tar.gz 05:40:39 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 05:40:39 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:40:39 INFO - Installing collected packages: blessings 05:40:39 INFO - Running setup.py install for blessings 05:40:39 INFO - Successfully installed blessings 05:40:39 INFO - Cleaning up... 05:40:39 INFO - Return code: 0 05:40:39 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:40:39 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:39 INFO - Reading from file tmpfile_stdout 05:40:39 INFO - Current package versions: 05:40:39 INFO - argparse == 1.2.1 05:40:39 INFO - blessings == 1.5.1 05:40:39 INFO - blobuploader == 1.2.4 05:40:39 INFO - docopt == 0.6.1 05:40:39 INFO - manifestparser == 1.1 05:40:39 INFO - mozInstall == 1.12 05:40:39 INFO - mozcrash == 0.16 05:40:39 INFO - mozdebug == 0.1 05:40:39 INFO - mozdevice == 0.48 05:40:39 INFO - mozfile == 1.2 05:40:39 INFO - mozhttpd == 0.7 05:40:39 INFO - mozinfo == 0.9 05:40:39 INFO - mozleak == 0.1 05:40:39 INFO - mozlog == 3.1 05:40:39 INFO - moznetwork == 0.27 05:40:39 INFO - mozprocess == 0.22 05:40:39 INFO - mozprofile == 0.28 05:40:39 INFO - mozrunner == 6.11 05:40:39 INFO - mozscreenshot == 0.1 05:40:39 INFO - mozsystemmonitor == 0.0 05:40:39 INFO - moztest == 0.7 05:40:39 INFO - mozversion == 1.4 05:40:39 INFO - psutil == 3.1.1 05:40:39 INFO - requests == 1.2.3 05:40:39 INFO - wsgiref == 0.1.2 05:40:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 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 0x7fdffb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', '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 05:40:39 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 05:40:39 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 05:40:39 INFO - Using env: {'DISPLAY': ':0', 05:40:39 INFO - 'HOME': '/home/cltbld', 05:40:39 INFO - 'LANG': 'en_US.UTF-8', 05:40:39 INFO - 'LANGUAGE': 'en_US:en', 05:40:39 INFO - 'LOGNAME': 'cltbld', 05:40:39 INFO - 'MAIL': '/var/mail/cltbld', 05:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:39 INFO - 'MOZ_NO_REMOTE': '1', 05:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:39 INFO - 'NO_EM_RESTART': '1', 05:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:39 INFO - 'SHELL': '/bin/bash', 05:40:39 INFO - 'SHLVL': '1', 05:40:39 INFO - 'TERM': 'linux', 05:40:39 INFO - 'TMOUT': '86400', 05:40:39 INFO - 'USER': 'cltbld', 05:40:39 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:39 INFO - '_': '/tools/buildbot/bin/python'} 05:40:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 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)) 05:40:39 INFO - Cleaning up... 05:40:39 INFO - Return code: 0 05:40:39 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:40:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:39 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 0x7fdffb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', '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 05:40:39 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 05:40:39 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 05:40:39 INFO - Using env: {'DISPLAY': ':0', 05:40:39 INFO - 'HOME': '/home/cltbld', 05:40:39 INFO - 'LANG': 'en_US.UTF-8', 05:40:39 INFO - 'LANGUAGE': 'en_US:en', 05:40:39 INFO - 'LOGNAME': 'cltbld', 05:40:39 INFO - 'MAIL': '/var/mail/cltbld', 05:40:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:39 INFO - 'MOZ_NO_REMOTE': '1', 05:40:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:39 INFO - 'NO_EM_RESTART': '1', 05:40:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:39 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:39 INFO - 'SHELL': '/bin/bash', 05:40:39 INFO - 'SHLVL': '1', 05:40:39 INFO - 'TERM': 'linux', 05:40:39 INFO - 'TMOUT': '86400', 05:40:39 INFO - 'USER': 'cltbld', 05:40:39 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:40:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:39 INFO - '_': '/tools/buildbot/bin/python'} 05:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:40 INFO - Downloading/unpacking jsonschema 05:40:40 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 05:40:40 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 05:40:40 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 05:40:40 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 05:40:40 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 05:40:40 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 05:40:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:40:41 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 05:40:41 INFO - Downloading/unpacking functools32 (from jsonschema) 05:40:41 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 05:40:41 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 05:40:41 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 05:40:41 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 05:40:41 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 05:40:41 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 05:40:42 INFO - Downloading functools32-3.2.3-2.tar.gz 05:40:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 05:40:42 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:40:42 INFO - warning: no files found matching '*.txt' 05:40:42 INFO - no previously-included directories found matching 'build' 05:40:42 INFO - no previously-included directories found matching 'dist' 05:40:42 INFO - no previously-included directories found matching '.git*' 05:40:42 INFO - Installing collected packages: jsonschema, functools32 05:40:42 INFO - Running setup.py install for functools32 05:40:42 INFO - warning: no files found matching '*.txt' 05:40:42 INFO - no previously-included directories found matching 'build' 05:40:42 INFO - no previously-included directories found matching 'dist' 05:40:42 INFO - no previously-included directories found matching '.git*' 05:40:42 INFO - Successfully installed jsonschema functools32 05:40:42 INFO - Cleaning up... 05:40:42 INFO - Return code: 0 05:40:42 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:40:42 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')]} 05:40:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:40:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:42 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')]} 05:40:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:40:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:40:42 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 0x7fdffb331f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16628a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1732630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, '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': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', '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 05:40:42 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 05:40:42 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 05:40:42 INFO - Using env: {'DISPLAY': ':0', 05:40:42 INFO - 'HOME': '/home/cltbld', 05:40:42 INFO - 'LANG': 'en_US.UTF-8', 05:40:42 INFO - 'LANGUAGE': 'en_US:en', 05:40:42 INFO - 'LOGNAME': 'cltbld', 05:40:42 INFO - 'MAIL': '/var/mail/cltbld', 05:40:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:40:42 INFO - 'MOZ_NO_REMOTE': '1', 05:40:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:40:42 INFO - 'NO_EM_RESTART': '1', 05:40:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:40:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:40:42 INFO - 'PWD': '/builds/slave/test-pgo', 05:40:42 INFO - 'SHELL': '/bin/bash', 05:40:42 INFO - 'SHLVL': '1', 05:40:42 INFO - 'TERM': 'linux', 05:40:42 INFO - 'TMOUT': '86400', 05:40:42 INFO - 'USER': 'cltbld', 05:40:42 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:40:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:40:42 INFO - '_': '/tools/buildbot/bin/python'} 05:40:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:40:42 INFO - Downloading/unpacking flake8 05:40:42 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 05:40:42 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 05:40:42 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 05:40:42 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 05:40:42 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 05:40:42 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 05:40:44 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:40:44 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 05:40:44 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:40:44 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 05:40:44 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 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 05:40:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 05:40:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:45 INFO - no previously-included directories found matching 'docs/_build' 05:40:45 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:40:45 INFO - Running setup.py install for pep8 05:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:40:45 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:40:45 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:40:45 INFO - no previously-included directories found matching 'docs/_build' 05:40:45 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:40:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:40:45 INFO - Cleaning up... 05:40:45 INFO - Return code: 0 05:40:45 INFO - Running post-action listener: _resource_record_post_action 05:40:45 INFO - Running post-action listener: _start_resource_monitoring 05:40:45 INFO - Starting resource monitoring. 05:40:45 INFO - ##### 05:40:45 INFO - ##### Running install step. 05:40:45 INFO - ##### 05:40:45 INFO - Running pre-action listener: _resource_record_pre_action 05:40:45 INFO - Running main action method: install 05:40:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:40:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:40:45 INFO - Reading from file tmpfile_stdout 05:40:45 INFO - Detecting whether we're running mozinstall >=1.0... 05:40:45 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:40:45 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:40:45 INFO - Reading from file tmpfile_stdout 05:40:45 INFO - Output received: 05:40:45 INFO - Usage: mozinstall [options] installer 05:40:45 INFO - Options: 05:40:45 INFO - -h, --help show this help message and exit 05:40:45 INFO - -d DEST, --destination=DEST 05:40:45 INFO - Directory to install application into. [default: 05:40:45 INFO - "/builds/slave/test-pgo"] 05:40:45 INFO - --app=APP Application being installed. [default: firefox] 05:40:45 INFO - mkdir: /builds/slave/test-pgo/build/application 05:40:45 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'] 05:40:45 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 05:41:01 INFO - Reading from file tmpfile_stdout 05:41:01 INFO - Output received: 05:41:01 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:41:01 INFO - Running post-action listener: _resource_record_post_action 05:41:01 INFO - ##### 05:41:01 INFO - ##### Running run-tests step. 05:41:01 INFO - ##### 05:41:01 INFO - Running pre-action listener: _resource_record_pre_action 05:41:01 INFO - Running main action method: run_tests 05:41:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:41:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:41:01 INFO - Python 2.7.3 05:41:01 INFO - Return code: 0 05:41:01 INFO - grabbing minidump binary from tooltool 05:41:01 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')]} 05:41:01 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 0x17c3840>, '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 0x17306b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1730b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:41:01 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 05:41:01 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 05:41:01 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:41:01 INFO - Return code: 0 05:41:01 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:41:01 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:41:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:41:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:41:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:41:01 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:41:01 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:41:02 INFO - Return code: 0 05:41:02 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:41:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 05:41:02 INFO - Using env: {'DISPLAY': ':0', 05:41:02 INFO - 'HOME': '/home/cltbld', 05:41:02 INFO - 'LANG': 'en_US.UTF-8', 05:41:02 INFO - 'LANGUAGE': 'en_US:en', 05:41:02 INFO - 'LOGNAME': 'cltbld', 05:41:02 INFO - 'MAIL': '/var/mail/cltbld', 05:41:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:41:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:41:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:41:02 INFO - 'MOZ_NO_REMOTE': '1', 05:41:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:41:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:41:02 INFO - 'NO_EM_RESTART': '1', 05:41:02 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:41:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:41:02 INFO - 'PWD': '/builds/slave/test-pgo', 05:41:02 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:41:02 INFO - 'SHELL': '/bin/bash', 05:41:02 INFO - 'SHLVL': '1', 05:41:02 INFO - 'TERM': 'linux', 05:41:02 INFO - 'TMOUT': '86400', 05:41:02 INFO - 'USER': 'cltbld', 05:41:02 INFO - 'XDG_SESSION_COOKIE': 'b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642', 05:41:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:41:02 INFO - '_': '/tools/buildbot/bin/python'} 05:41:02 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 05:41:02 INFO - mozversion application_buildid: 20160115023017 05:41:02 INFO - mozversion application_changeset: b8a038770d4c3ac1c108e95da19867ad6fe96cbb 05:41:02 INFO - mozversion application_display_name: Nightly 05:41:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:41:02 INFO - mozversion application_name: Firefox 05:41:02 INFO - mozversion application_remotingname: firefox 05:41:02 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:41:02 INFO - mozversion application_vendor: Mozilla 05:41:02 INFO - mozversion application_version: 46.0a1 05:41:02 INFO - mozversion platform_buildid: 20160115023017 05:41:02 INFO - mozversion platform_changeset: b8a038770d4c3ac1c108e95da19867ad6fe96cbb 05:41:02 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:41:02 INFO - mozversion platform_version: 46.0a1 05:41:02 INFO - using testdate: 1452865262 05:41:02 INFO - actual date: 1452865262 05:41:02 INFO - starting webserver on 'localhost:56044' 05:41:02 INFO - SUITE-START | Running 3 tests 05:41:02 INFO - TEST-START | dromaeo_css 05:41:02 INFO - operating with platform_type : linux_ 05:41:02 INFO - Initialising browser for dromaeo_css test... 05:41:02 INFO - TEST-INFO | started process 4451 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0uXLqp/profile http://localhost:56044/getInfo.html) 05:41:07 INFO - PROCESS | 4451 | __metrics Screen width/height:1600/1200 05:41:07 INFO - PROCESS | 4451 | colorDepth:24 05:41:07 INFO - PROCESS | 4451 | Browser inner width/height: 1024/697 05:41:07 INFO - PROCESS | 4451 | __metrics 05:41:07 INFO - PROCESS | 4451 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:41:07 INFO - PROCESS | 4451 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:41:08 INFO - TEST-INFO | 4451: exit 0 05:41:08 INFO - Browser initialized. 05:41:08 INFO - Running cycle 1/1 for dromaeo_css test... 05:41:08 INFO - TEST-INFO | started process 4545 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp0uXLqp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:41:20 INFO - PROCESS | 4545 | RSS: Main: 150011904 05:41:20 INFO - PROCESS | 4545 | 05:42:11 INFO - PROCESS | 4545 | 1452865331591 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] 05:44:19 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:56044/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56044/tests/dromaeo/cssquery-ext.html) 05:44:20 INFO - PROCESS | 4545 | RSS: Main: 240476160 05:44:20 INFO - PROCESS | 4545 | 05:47:23 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:56044/tests/dromaeo/cssquery-ext.html (next: http://localhost:56044/tests/dromaeo/cssquery-jquery.html) 05:47:23 INFO - PROCESS | 4545 | RSS: Main: 232034304 05:47:23 INFO - PROCESS | 4545 | 05:50:25 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:56044/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56044/tests/dromaeo/cssquery-mootools.html) 05:50:26 INFO - PROCESS | 4545 | RSS: Main: 222289920 05:50:26 INFO - PROCESS | 4545 | 05:53:28 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:56044/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56044/tests/dromaeo/cssquery-prototype.html) 05:53:28 INFO - PROCESS | 4545 | RSS: Main: 206659584 05:53:28 INFO - PROCESS | 4545 | 05:56:31 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:56044/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56044/tests/dromaeo/cssquery-yui.html) 05:56:32 INFO - PROCESS | 4545 | RSS: Main: 210202624 05:56:32 INFO - PROCESS | 4545 | 05:59:34 INFO - PROCESS | 4545 | Cycle 1(1): loaded http://localhost:56044/tests/dromaeo/cssquery-yui.html (next: http://localhost:56044/tests/dromaeo/cssquery-dojo.html) 05:59:34 INFO - PROCESS | 4545 | RSS: Main: 237010944 05:59:34 INFO - PROCESS | 4545 | 05:59:34 INFO - PROCESS | 4545 | __start_tp_report 05:59:34 INFO - PROCESS | 4545 | _x_x_mozilla_page_load 05:59:34 INFO - PROCESS | 4545 | _x_x_mozilla_page_load_details 05:59:34 INFO - PROCESS | 4545 | |i|pagename|runs| 05:59:34 INFO - PROCESS | 4545 | |0;dojo.html;3018.8188708677476;3052.908412747616;3117.158367240845;3127.249460129568;3155.258514249151;4919.212925931852;5015.297858299841;5042.722650254234;5066.518680725325;5093.26147708582;4908.607311415087;4985.027919555679;5045.924311135336;5156.716380599066;5157.123289040863;4579.793909274091;4600.700954437959;4622.560856718606;4646.326282689008;4737.857864264078;4316.283949287414;4634.559716826896;4802.83190088347;4817.22924332107;4825.059113472857;4468.731876087445;4518.457785065781;4536.432945881765;4746.169420351424;4807.855764327076;4591.104734576759;4595.126925884071;4596.080783843245;4602;4612.077584483117;4566.680332376735;4572.1312950539295;4574.794134263966;4581.152486789954;4584.12901548708;4828.517148285178;4836.85489435314;4837.32277481153;4846.345743324677;4854.417469903634;5347.224652425415;5355;5358.437364076754;5358.973205133989;5408;5187.04039752647;5276.12943864262;5327.627066105374;5366.812161574326;5370.3287089113865;4948.3072369868605;5039.420466646346;5048.848534543969;5061.367329083864;5095.821646242363;5459.781608735606;5460.31746031746;5465.234867118606;5465.863353416117;5466.590005749585;5141.177411614124;5220.112580861262;5276.445973172838;5304.867378315573;5401.810936617199;5341.198820177005;5346.91979620306;5351.892962140735;5359.1157459019605;5360.437154098841;5318.25544423781;5318.946810531923;5321.228421878806;5326.121190003606;5367.704776237267;5199.428062913076;5276.525112739795;5310.840674779763;5331.546818520469;5401.135818269058;4230.048239146167;4242.787860606957;4249.2563801334645;4256.510501292391;4288.4210631564965;3785.2618739346112;3803.3724435468393;3825.1967086911504;3836.7889766063136;3864.574896761354;4923.655344125948;5003.824866129668;5034.622403319766;5058.519440653132;5084.847454576368;5350.27771250884;5362.088444964365;5372.7313634318125;5379.67721936685;5435.809746658848;4843.636727245471;4909.484504127086;5006.74966251686;5017.623678224148;5022.949770502321;4604.102200070954;4641.628669706415;4655.650826188049;4674.906501869944;4686.95313046872;5443.482869127506;5484.945150548523;5491.697956612345;5491.835244942578;5521.475459831309;5234.450382709761;5299.655522391032;5302.946970530245;5304.549113325256;5311.920321195263;5471.863203419946;5482.533984611353;5490.396056433709;5497.670139791625;5548.667079975215;5178.559822415137;5201.791928322976;5221.738913054408;5227.947720522899;5244.160934250502;5191.76637051326;5285.656432331886;5298.841034768963;5300.443453437333;5301.920471192858;5151.587872970078;5166.147585648477;5170.482951704799;5175.301334319819;5223.059849227176;5187.507186817246;5223.4515375884985;5240.371155461369;5244.134717771678;5283.947160528345;4977.751112444435;5067.113255180255;5153.072446959433;5154.7938082476285;5166.095933211598;5203.089459344676;5220.399654039834;5222.033923724123;5246.134387825966;5246.606504512253;5057.367829021372;5060.569851562658;5092.439831618445;5094.388673359221;5098.821541246187 05:59:34 INFO - PROCESS | 4545 | |1;ext.html;520.1261880041532;535.9356877174739;556.9136783798511;588.7438964050639;591.2107336705498;27757.722422775765;28477;28540.143795686163;28560.857195713994;35194.64805351946;38007.42988855169;38594.614053859455;38883.22233555334;38901.61098389023;38959.22081558367;8536;8791.73624791254;8792.560371981408;8793;8799.164079412445;7468.813279667997;7474;7490.588017659026;7501.174870764239;8491.532965686885;10086.89913100867;10253.384796912173;10265.743356416075;10287.537060832243;10291.433971131584;9836.213102951782;9975.401475911396;10003.14973227273;10008.899911000906;10017.749556261078;10230.130438912627;10412.375257484575;10415.68752937413;10417.947910260476;10424.947875260576;39094;39638.60361396378;39742.20515589672;39753.80123099395;39768.801155994326;3191;3277.2462333663393;3447.620761716209;3653.598104208535;3856.1709232514863;27353.31616709578;28410.715892841014;28707.42585148306;29111.41777164466;29358.266043348875;3734.3464893643504;3734.5705243897028;3746.906327341811;3756.3050835595227;3923.391874259494;263589;270663.6466817673;271294;271616;271620;54499;61441.69279153665;62169.689151553954;62274.68862655749;62329.688351557954;57592.4240757587;67452.32547674558;68119.20986716085;68512.6574367125;68566;14640.341184646717;14734.484293049692;14736.631584210267;14741.262936853114;14835.703285934436;12125.211861228992;12146.271223726604;12221.327826969424;12239;12254.387280635932;20800.375988720363;21129.154833806784;21171.78828211729;21178;21204.15183392647;8246.54643994586;8509.872891518096;8511.95744021276;8557.957210214034;8558.61486233121;914.1818072824784;931.7204838548408;981.9901800981899;1022.5858527296457;1030.5568605499557;26662.866685666446;27190.73966801844;27384.58923116155;27398.315042124108;27587.586186207223;961.4183419031525;1042.6663467690419;1060.3531845574194;1066.4401189375485;1176.9470373833199;14174.416930250087;14175.362108705132;14346.49787257441;14372.209528475825;14411;401083;406202;407709;408116;408925;53062;53727.46272537303;53760.19359709608;53875.844966201694;53946;1300.232862611064;1309.4173092973535;1319.4722111155615;1331.9876893560963;1332.1074879830537;26677.466450671265;27007.86496067507;27466.862665686545;27794;27854;40913.79543102384;41512.584874150874;41513.50918944873;41657;42481.725548233604;298618;298691;298748;300447;300695;28173.859130704215;28553.28616784597;31871.043868683977;32398.676013239565;32973.83513082419;37052.44421333736;37254.627453725116;37512.2497550042;37623.81188094042;38016.42975355427;34488.13779655529;34905.47641785426;35012.649873501956;37857.81071094627;39170.60829391784;32035;34199.31601368009;36208.637913621584;37755.62244377521;38379.808100959315;33311.66688333086;33550.32899342048;33569.66430335665;33777.15557111092;33780.49329260014;32070.67929320677;32579.511307329936;33126.33747324992;33248;33478.83260583682;25288.62067069032;31774;31837.20406989844;32159.14090309178;33843 05:59:34 INFO - PROCESS | 4545 | |2;jquery.html;348.7907255646612;357.6441440766438;366.6278727092001;367.94296883982975;370.23731113905353;13508.18950862949;13953.930230348835;15944.441944531929;16174;16983.320667173313;14866.925665371686;14968.775468367956;15627.531174064768;15661.530154095366;15675.843241567582;5113.5909127269915;5227.163653815391;5268.367795864501;5285.6300058995885;5302.125149350352;3569.6078529373567;3715.3126671565847;3724.255148970203;5107.795688172488;5228.47715228478;5247.553957913563;5264.842054738345;5268.710220937847;5294.1529355303155;5330.480812968305;5454.809081682142;5794.101914203306;5806.65160090396;5820.3121094882645;5827.417258274181;5038.496150384969;5186.429492755794;5190.896182076337;5281.445448227919;5301.469853014706;11707.121965852595;11919.523219071227;12422.254664720145;16522.339106435727;20300.289489867784;1987.791281915407;2088.1229883448987;2091.780363061887;2120.7561130469885;2139.721836161289;8522.57387130641;8889.111088891059;9179.449233046038;11015.779684406267;13046.54337098197;1715.5282297368199;1792.6145878636025;1799.595091104491;1816.5640246340915;1822.1526989949737;55201.44798552043;55627.16559251615;55687;56286.15570766442;56446.717766410904;10134.138598219233;10169.694909152737;10176.898231017743;10193.23550733698;10210.13213876814;12883.227006379648;12970.481180752664;12979.286139262242;12994.740105197843;12996.67508312281;7243.963780181065;7321.11814893998;7356.448266379936;7368;7386.224446433154;6975.197852246955;7076.716931322792;7097.787066388017;7128.893066604005;7148.428125749928;4324.9135017300105;4412.3160910059;4415.425994620743;4454.354118652777;4457.687961842705;1725.3184991928117;1778.119830683794;1783.9108044597717;1803.5220666523383;1827.3421568235424;867.9262262707614;872.646578135856;920.4109370003204;1006.8489726541078;1016.2885979814159;13415.205961870235;16169.59576010609;16405.67188656244;16470.247198648736;16618.33526658944;862.5126803356209;888.2316795971567;890.4523717913437;902.566767951387;902.9006809250977;8026.638801253957;9116.81766364669;9265.629374825066;9696.51517424126;9724.465154416575;410967;415581;461796;540716;543191;70906.64546677233;71403;74331.25668743352;75015;75626.62186689032;1117.4580328540815;1118.8377685235432;1119.5409881948362;1138.1748232531513;1143.1997601678859;14059.437622495394;14805.629859253604;14975.775363369341;15235.619109522351;15310.31103600363;30961.535576965915;32478.35043299168;33240.66759332376;33567.832160840015;34321;40788.38817417682;41382.37926431166;41642.58357416508;42058.7897060525;42119.57880421279;3076.415481058592;3108.6114235720534;5507.925954438846;6851.526921711856;7086.255943125898;8206.425550211428;11025.779484410106;11351;11367.317960922372;11385.886141138482;9539.189168920442;9765.169960553432;9809.16622087102;10061.144802691853;10124.088832005154;9729.513524323615;9855.86657534364;10035.397876127456;10189.23580731463;10225.284230103822;9303;9656.95171524138;9773.511324433608;9978.60085596568;10063.194944404577;7129.500934934505;7166.498345115792;7251.709931602677;7254.238304978113;7263.237360077116;7219.927800721925;9690.612375505183;10047.748806279902;10217.795644087226;10264.538095785856 05:59:34 INFO - PROCESS | 4545 | |3;mootools.html;1292.399034448981;1441.9711605767884;1454.440040584375;1565.9564268629442;1750.186163434003;6804.863902721949;7519.54882707038;7670.808229794258;7676.539407635546;7704.807379815507;7526.661300241489;7739.845203095949;7761.379089672827;7771.261730135642;7781.883271750914;1973.2501649373219;2017.5964807038577;2228.699125618045;2303.044236641796;2329.906803727849;2304.377817989142;2310.607196776544;2314.1206341590173;2314.7222333320024;2315.8610483370967;2210.8231341492724;2292.5071109711407;2293.472501324696;2295.690081838947;2298.8505747126383;2257.5146343536135;2262.886855657219;2272.363738153328;2292.048799748119;2294.678744975705;2279.3048120323297;2289.610766169755;2296.9196078137184;2308.676785250066;2336.836421450499;7614.048243969504;7677.2322767723335;7703.268189521987;7705.383569314497;7711.5758633275145;4658.231391820379;4749;4785.138675038492;4791.832285870013;4815.879603009953;2907.86914588844;2946.6169397978124;2995.4907665696664;2996.595459612968;3035.650900146489;935.6397786852111;953.323140570196;971.4220039076808;976.414151509096;994.7612572982505;10879.292845965067;10880.455977201109;10882.183836212316;10898.291611045257;10924.672259832218;4345.760983145894;4436.800343984464;4444.911101777946;4454.398656181439;4478.39541661878;9391;9402.858957115648;9408.341416100808;9410.482423466776;9417.293702972167;4815.590674792682;4827.686200396963;4847.466778654345;4847.684900481458;4856.150173719656;4346.7826608670075;4358.6295164911335;4401.2517871961845;4405.052913623586;4405.140997505519;3394.253264281854;3415.7438192135687;3642.18050938542;3709.5177626908867;3760.0599850037493;1164.4527072276016;1176.2472017908544;1185.9229150105216;1193.9701507462382;1206.3365149168098;1057.2176589323844;1058.1799105692996;1206.9396530173456;1227.147132742753;1247.5321754342121;6827.317268273232;6860.725570977105;6915.51591388598;6917.688704008231;7364.521306115085;1059.1209296284067;1081.7566047639375;1089.9019088282093;1090.1006669497538;1118.681175864891;5756.107803290497;5767.8558036049435;5818.854528636818;5844.415558444207;5845.1232315153065;9273.443593384418;9432.528373581294;9586.37031704612;9588.952055239819;9599.42403455795;9451.574679139456;9460.716178514518;9469.573869175903;9583.520823958774;9670;7201.675924583406;7336.193018767931;7346.081739782528;7417.925820741832;7421.257874212535;7128.4653650977425;7179.425645948416;7200.135983681992;7207.8558428832175;7238.674259658223;8412.158784121539;8466.153384661484;8541.316694664287;8611.569421529024;8619.91380086191;8694.08712085222;8755.387122901591;8900.06549312313;8921.15249051339;9033.548322583976;6937.340952609494;6954.721811127498;7018.087648605649;7034.472414568825;7043.471739619446;6497.25281592604;6599.7360105595235;7249.782506524602;7489.70041198346;7507.662155203138;6875.4155896749335;6957.721691132298;7040.436765058886;7058.470614703815;7074.080369551925;6837.213720422215;6907.585544867324;6911.032455456139;6920.204176519765;6941.82645433848;6687.264400915993;6739.191297044386;6783.728650853911;6795.72817087311;6796.150481189851;5920.2895652521975;6058.757649694139;6075;6077.513798896166;6078.45293923549;6345.4923606112325;6556.246031706415;6561.1470508833545;6562.2125344957;6567.704453299518 05:59:34 INFO - PROCESS | 4545 | |4;prototype.html;336.80970251807724;341.3633573385635;341.82396066025984;346.0604458894102;351.62025012985964;5795.971020144893;5916.792912248066;5947.4944629706415;5951.702414879255;5956.672383018932;5720.713964301779;5822.883542329151;5844.064949608053;5886.146508756238;5889.970550147254;4594.402727645418;4595.058013107313;4595.609373203265;4596.862094137181;4604.539546045402;4388.210122178007;4470.955290447087;4481.350204220386;4578.473475550304;4587.357769912215;4472.373867658531;4473.865784026484;4479.753613551254;4504.62608904284;4506.52681468446;4484.103179364108;4502.482214545336;4516.458025037;4548.545145485458;4566.1780879441685;4023.1350259694013;4026.45642838216;4027.2952233359047;4036.7577945323374;4042.1309418474875;5494.120940649477;5631.211630371751;5652.3217213934595;5661.7735290588325;5668.404817494186;5253.106971814763;5255.1329030709885;5263.6578622389425;5264.842054738364;5267.920981185285;5937.732802023919;6306.432421082079;6307.05394190875;6311.93688063118;6319.336469670664;4179.185058913513;4251.383549385322;4313.460817397825;4317.892052698676;4322.978385108055;6361;6530.346965303432;6534.967325163391;6543.770968016097;6544.9672751635935;4441.71128876622;4450.710703804242;4463.687541872037;4465.441819772528;4474.686771925999;4456.688031837805;4503.437070366204;4528.728276303433;4530.728156310566;4545.522720114406;5202.271681964528;5206.947930520646;5213.400458947193;5216.4522725114075;5236.24074509194;6243.562950593415;6268.122462855204;6274.874502509924;6277.121203031579;6283.7800676976085;1586.7143914095343;1604.5667669729341;1605.4300723243314;1607.3490236454254;1613;1073.0985971783582;1075.800976819291;1085.696005118568;1091.1325496230515;1103.100972707241;5966.254218222723;5970.283565972111;5975.910361344583;5977.163197152402;5981.760729570856;6482.57863238888;6483.448906842971;6486.059521369375;6494.350564943468;6497.675116244169;5908.409159084057;5914.733836977346;5916.822495325061;5917.615355001911;5928.703564821828;3431.0736101252523;3531.7351198660203;3541.1678255609913;3542.946855797165;3543.7519373644113;6848;6852.657367131624;6854.6229957351825;6857.519973601899;6857.691403886837;6643.667816609151;6678.332166783282;6684.4318232950745;6694.665266736741;6707.49693772969;6621.966890165519;6804.829879253059;6818.8636227276165;6819.31806819324;6824.41992430639;6271.78048768291;6411.166548348685;6537.05212744159;6543.443807276435;6547.345265473415;6282.340354262737;6459.935400645933;6512.54412191161;6520.315366886409;6539.378759017885;6776.559523630948;6782.796516104525;6788.389044985975;6790.830229244309;6794.83012924661;4279.293916503742;4455.108978204437;4501.887452813706;4504.63962882962;4506.098780243899;6398.264199617103;6464.967675161783;6468.708908099053;6478.352164783484;6485.902711459237;6276.278228003838;6288.182536270256;6289.088082228142;6297.96851015742;6323.747050117944;6176.227971503562;6220.129181914626;6275.780347687809;6280.9685951569945;6286.057091436322;6111.563782511195;6113.358097399709;6117.143599896107;6121.112438696453;6121.143039974496;6290.874182516415;6299.76358392764;6310.242770867525;6311.075122087807;6325.304216536269;6063.454289114001;6102.359252278625;6152.938470615416;6157.353477884937;6162.26052873658 05:59:34 INFO - PROCESS | 4545 | |5;yui.html;751.2037240525044;824.3405275779375;831.9334453243741;835.561330301592;857.3526987124721;13271.137376070561;13435.932820335896;13439.865601343983;13443.596692099229;13458.865411345883;12149.271043737383;12176.452059657337;12178.269303841776;12192.81710774339;12651.304178270191;799.2007992007992;807.0315621254489;807.0758980966818;807.2734538914995;807.3621838747382;800.3157300508069;813.8657121574932;816.4081041245109;817.3951276055735;817.4972391978949;850.1795767084762;852.5694524265238;852.910444403338;853.0701535326493;853.2320911179926;848.2874385516196;849.0914721248267;850.056437354536;850.1328644782318;850.4727069217095;623.3797371615226;625.5183508698323;625.8185126313364;627.5857933763695;627.6830200748639;10787.730306742316;11111.611093611766;12593.496260149583;12629.305388203646;13398.732025359439;12246;12312.076594255466;12366.381680915918;12615;12858.807117893239;9784.559694813679;9802.754931126708;9853.556589953469;10068.899311006942;10107.848382274271;3600.747947643666;3641.9074277716577;3646.5988741238443;3646.9270614587826;3656.981715091434;46967.76516117398;47433;47882.802929926685;48628.513714863104;48670.75664621654;9794.461304628314;9859.26055545837;10133.64532241368;10207.081362677394;10267.537960791782;18418.907905460386;18429.170687319103;18475.90762046208;18497.445076647724;18526.629467410577;7083.220845706968;7174.569525828467;7175.712971481083;7201.207867134611;7628.389728821681;4101.753894766264;4110.157417729359;4159.542450330461;4224.091820258659;4273.358996150602;3000.8799648014274;3029.2881172924344;3033.726964573199;3045.284358175827;3048.222703210667;530.247049190151;545.4082320682026;549.3270743339457;554.365251786702;559.862833605761;541.2557733116964;599.7570983751588;607.8784243151388;634.1110041579474;658.9439897608661;7834.099078605919;8160.510369377737;8177.632006559719;8180.46826956246;8191.590420479071;612.8467883029243;614.3181069013481;622.2564035977055;639.2776162935945;670.24597328006;3786.753860999026;3788.6969042476535;3818.3317919364;3917.334053210904;3925.4896863408144;56454;56941.14588281179;58802.41197588055;58961.70519147377;59212;50360.24459633108;51351.229731554056;51486;51507.48492515102;51702.22446663303;45613.543864561594;46401.99999999932;46538.76730616325;46876.7656161717;46886.06227875423;7681.539107653559;7707.807304817425;7824.569648669378;8098.190180981855;8679.392442529215;34175.487367689006;34259.314813704084;35182;36998.63001369952;37897;45836.54163458323;45921;46746;47630.761846190544;47995.520044800505;11069.83395249088;11178.552857885594;11275.15436342294;11367.090632749525;11372.886271137182;11663.825042624538;11710.88289117132;11849.111316651459;11937.761244774882;12096.274223546616;10285.125764310118;10523.789524209626;10534.315269507457;10689.412082335235;10761.569537218424;10006.849897251692;10214.693559193236;10504;10520;10738.83891741609;10309;10326.122279606017;10408.47957602132;10451.268411211142;10473.26687131924;8703.95648021756;8710.780490731177;8887.333449991405;9005.504697241715;9011.684591039282;7758.340541053848;8063;8264.462809917337;8612.827743445221;9088.136627020422 05:59:34 INFO - PROCESS | 4545 | __end_tp_report 05:59:34 INFO - PROCESS | 4545 | __start_cc_report 05:59:34 INFO - PROCESS | 4545 | _x_x_mozilla_cycle_collect,757 05:59:34 INFO - PROCESS | 4545 | __end_cc_report 05:59:34 INFO - PROCESS | 4545 | __startTimestamp1452866374907__endTimestamp 05:59:34 INFO - PROCESS | 4545 | 05:59:34 INFO - PROCESS | 4545 | ------- Summary: start ------- 05:59:34 INFO - PROCESS | 4545 | Number of tests: 6 05:59:34 INFO - PROCESS | 4545 | 05:59:34 INFO - PROCESS | 4545 | [#0] dojo.html Cycles:165 Average:4976.69 Median:5153.07 stddev:505.51 (9.8%) stddev-sans-first:483.17 05:59:34 INFO - PROCESS | 4545 | Values: 3018.8 3052.9 3117.2 3127.2 3155.3 4919.2 5015.3 5042.7 5066.5 5093.3 4908.6 4985.0 5045.9 5156.7 5157.1 4579.8 4600.7 4622.6 4646.3 4737.9 4316.3 4634.6 4802.8 4817.2 4825.1 4468.7 4518.5 4536.4 4746.2 4807.9 4591.1 4595.1 4596.1 4602.0 4612.1 4566.7 4572.1 4574.8 4581.2 4584.1 4828.5 4836.9 4837.3 4846.3 4854.4 5347.2 5355.0 5358.4 5359.0 5408.0 5187.0 5276.1 5327.6 5366.8 5370.3 4948.3 5039.4 5048.8 5061.4 5095.8 5459.8 5460.3 5465.2 5465.9 5466.6 5141.2 5220.1 5276.4 5304.9 5401.8 5341.2 5346.9 5351.9 5359.1 5360.4 5318.3 5318.9 5321.2 5326.1 5367.7 5199.4 5276.5 5310.8 5331.5 5401.1 4230.0 4242.8 4249.3 4256.5 4288.4 3785.3 3803.4 3825.2 3836.8 3864.6 4923.7 5003.8 5034.6 5058.5 5084.8 5350.3 5362.1 5372.7 5379.7 5435.8 4843.6 4909.5 5006.7 5017.6 5022.9 4604.1 4641.6 4655.7 4674.9 4687.0 5443.5 5484.9 5491.7 5491.8 5521.5 5234.5 5299.7 5302.9 5304.5 5311.9 5471.9 5482.5 5490.4 5497.7 5548.7 5178.6 5201.8 5221.7 5227.9 5244.2 5191.8 5285.7 5298.8 5300.4 5301.9 5151.6 5166.1 5170.5 5175.3 5223.1 5187.5 5223.5 5240.4 5244.1 5283.9 4977.8 5067.1 5153.1 5154.8 5166.1 5203.1 5220.4 5222.0 5246.1 5246.6 5057.4 5060.6 5092.4 5094.4 5098.8 05:59:34 INFO - PROCESS | 4545 | 05:59:34 INFO - PROCESS | 4545 | [#1] ext.html Cycles:180 Average:48761.59 Median:33514.58 stddev:86949.67 (259.4%) stddev-sans-first:87118.14 05:59:34 INFO - PROCESS | 4545 | Values: 520.1 535.9 556.9 588.7 591.2 27757.7 28477.0 28540.1 28560.9 35194.6 38007.4 38594.6 38883.2 38901.6 38959.2 8536.0 8791.7 8792.6 8793.0 8799.2 7468.8 7474.0 7490.6 7501.2 8491.5 10086.9 10253.4 10265.7 10287.5 10291.4 9836.2 9975.4 10003.1 10008.9 10017.7 10230.1 10412.4 10415.7 10417.9 10424.9 39094.0 39638.6 39742.2 39753.8 39768.8 3191.0 3277.2 3447.6 3653.6 3856.2 27353.3 28410.7 28707.4 29111.4 29358.3 3734.3 3734.6 3746.9 3756.3 3923.4 263589.0 270663.6 271294.0 271616.0 271620.0 54499.0 61441.7 62169.7 62274.7 62329.7 57592.4 67452.3 68119.2 68512.7 68566.0 14640.3 14734.5 14736.6 14741.3 14835.7 12125.2 12146.3 12221.3 12239.0 12254.4 20800.4 21129.2 21171.8 21178.0 21204.2 8246.5 8509.9 8512.0 8558.0 8558.6 914.2 931.7 982.0 1022.6 1030.6 26662.9 27190.7 27384.6 27398.3 27587.6 961.4 1042.7 1060.4 1066.4 1176.9 14174.4 14175.4 14346.5 14372.2 14411.0 401083.0 406202.0 407709.0 408116.0 408925.0 53062.0 53727.5 53760.2 53875.8 53946.0 1300.2 1309.4 1319.5 1332.0 1332.1 26677.5 27007.9 27466.9 27794.0 27854.0 40913.8 41512.6 41513.5 41657.0 42481.7 298618.0 298691.0 298748.0 300447.0 300695.0 28173.9 28553.3 31871.0 32398.7 32973.8 37052.4 37254.6 37512.2 37623.8 38016.4 34488.1 34905.5 35012.6 37857.8 39170.6 32035.0 34199.3 36208.6 37755.6 38379.8 33311.7 33550.3 33569.7 33777.2 33780.5 32070.7 32579.5 33126.3 33248.0 33478.8 25288.6 31774.0 31837.2 32159.1 33843.0 05:59:34 INFO - PROCESS | 4545 | 05:59:34 INFO - PROCESS | 4545 | [#2] jquery.html Cycles:180 Average:25341.72 Median:228611.79 stddev:78241.02 (34.2%) stddev-sans-first:78438.00 05:59:34 INFO - PROCESS | 4545 | Values: 348.8 357.6 366.6 367.9 370.2 13508.2 13953.9 15944.4 16174.0 16983.3 14866.9 14968.8 15627.5 15661.5 15675.8 5113.6 5227.2 5268.4 5285.6 5302.1 3569.6 3715.3 3724.3 5107.8 5228.5 5247.6 5264.8 5268.7 5294.2 5330.5 5454.8 5794.1 5806.7 5820.3 5827.4 5038.5 5186.4 5190.9 5281.4 5301.5 11707.1 11919.5 12422.3 16522.3 20300.3 1987.8 2088.1 2091.8 2120.8 2139.7 8522.6 8889.1 9179.4 11015.8 13046.5 1715.5 1792.6 1799.6 1816.6 1822.2 55201.4 55627.2 55687.0 56286.2 56446.7 10134.1 10169.7 10176.9 10193.2 10210.1 12883.2 12970.5 12979.3 12994.7 12996.7 7244.0 7321.1 7356.4 7368.0 7386.2 6975.2 7076.7 7097.8 7128.9 7148.4 4324.9 4412.3 4415.4 4454.4 4457.7 1725.3 1778.1 1783.9 1803.5 1827.3 867.9 872.6 920.4 1006.8 1016.3 13415.2 16169.6 16405.7 16470.2 16618.3 862.5 888.2 890.5 902.6 902.9 8026.6 9116.8 9265.6 9696.5 9724.5 410967.0 415581.0 461796.0 540716.0 543191.0 70906.6 71403.0 74331.3 75015.0 75626.6 1117.5 1118.8 1119.5 1138.2 1143.2 14059.4 14805.6 14975.8 15235.6 15310.3 30961.5 32478.4 33240.7 33567.8 34321.0 40788.4 41382.4 41642.6 42058.8 42119.6 3076.4 3108.6 5507.9 6851.5 7086.3 8206.4 11025.8 11351.0 11367.3 11385.9 9539.2 9765.2 9809.2 10061.1 10124.1 9729.5 9855.9 10035.4 10189.2 10225.3 9303.0 9657.0 9773.5 9978.6 10063.2 7129.5 7166.5 7251.7 7254.2 7263.2 7219.9 9690.6 10047.7 10217.8 10264.5 05:59:34 INFO - PROCESS | 4545 | 05:59:34 INFO - PROCESS | 4545 | [#3] mootools.html Cycles:180 Average:5455.90 Median:6421.37 stddev:2848.81 (44.4%) stddev-sans-first:2839.61 05:59:34 INFO - PROCESS | 4545 | Values: 1292.4 1442.0 1454.4 1566.0 1750.2 6804.9 7519.5 7670.8 7676.5 7704.8 7526.7 7739.8 7761.4 7771.3 7781.9 1973.3 2017.6 2228.7 2303.0 2329.9 2304.4 2310.6 2314.1 2314.7 2315.9 2210.8 2292.5 2293.5 2295.7 2298.9 2257.5 2262.9 2272.4 2292.0 2294.7 2279.3 2289.6 2296.9 2308.7 2336.8 7614.0 7677.2 7703.3 7705.4 7711.6 4658.2 4749.0 4785.1 4791.8 4815.9 2907.9 2946.6 2995.5 2996.6 3035.7 935.6 953.3 971.4 976.4 994.8 10879.3 10880.5 10882.2 10898.3 10924.7 4345.8 4436.8 4444.9 4454.4 4478.4 9391.0 9402.9 9408.3 9410.5 9417.3 4815.6 4827.7 4847.5 4847.7 4856.2 4346.8 4358.6 4401.3 4405.1 4405.1 3394.3 3415.7 3642.2 3709.5 3760.1 1164.5 1176.2 1185.9 1194.0 1206.3 1057.2 1058.2 1206.9 1227.1 1247.5 6827.3 6860.7 6915.5 6917.7 7364.5 1059.1 1081.8 1089.9 1090.1 1118.7 5756.1 5767.9 5818.9 5844.4 5845.1 9273.4 9432.5 9586.4 9589.0 9599.4 9451.6 9460.7 9469.6 9583.5 9670.0 7201.7 7336.2 7346.1 7417.9 7421.3 7128.5 7179.4 7200.1 7207.9 7238.7 8412.2 8466.2 8541.3 8611.6 8619.9 8694.1 8755.4 8900.1 8921.2 9033.5 6937.3 6954.7 7018.1 7034.5 7043.5 6497.3 6599.7 7249.8 7489.7 7507.7 6875.4 6957.7 7040.4 7058.5 7074.1 6837.2 6907.6 6911.0 6920.2 6941.8 6687.3 6739.2 6783.7 6795.7 6796.2 5920.3 6058.8 6075.0 6077.5 6078.5 6345.5 6556.2 6561.1 6562.2 6567.7 05:59:34 INFO - PROCESS | 4545 | 05:59:34 INFO - PROCESS | 4545 | [#4] prototype.html Cycles:180 Average:5255.64 Median:5923.16 stddev:1581.98 (26.7%) stddev-sans-first:1542.74 05:59:34 INFO - PROCESS | 4545 | Values: 336.8 341.4 341.8 346.1 351.6 5796.0 5916.8 5947.5 5951.7 5956.7 5720.7 5822.9 5844.1 5886.1 5890.0 4594.4 4595.1 4595.6 4596.9 4604.5 4388.2 4471.0 4481.4 4578.5 4587.4 4472.4 4473.9 4479.8 4504.6 4506.5 4484.1 4502.5 4516.5 4548.5 4566.2 4023.1 4026.5 4027.3 4036.8 4042.1 5494.1 5631.2 5652.3 5661.8 5668.4 5253.1 5255.1 5263.7 5264.8 5267.9 5937.7 6306.4 6307.1 6311.9 6319.3 4179.2 4251.4 4313.5 4317.9 4323.0 6361.0 6530.3 6535.0 6543.8 6545.0 4441.7 4450.7 4463.7 4465.4 4474.7 4456.7 4503.4 4528.7 4530.7 4545.5 5202.3 5206.9 5213.4 5216.5 5236.2 6243.6 6268.1 6274.9 6277.1 6283.8 1586.7 1604.6 1605.4 1607.3 1613.0 1073.1 1075.8 1085.7 1091.1 1103.1 5966.3 5970.3 5975.9 5977.2 5981.8 6482.6 6483.4 6486.1 6494.4 6497.7 5908.4 5914.7 5916.8 5917.6 5928.7 3431.1 3531.7 3541.2 3542.9 3543.8 6848.0 6852.7 6854.6 6857.5 6857.7 6643.7 6678.3 6684.4 6694.7 6707.5 6622.0 6804.8 6818.9 6819.3 6824.4 6271.8 6411.2 6537.1 6543.4 6547.3 6282.3 6459.9 6512.5 6520.3 6539.4 6776.6 6782.8 6788.4 6790.8 6794.8 4279.3 4455.1 4501.9 4504.6 4506.1 6398.3 6465.0 6468.7 6478.4 6485.9 6276.3 6288.2 6289.1 6298.0 6323.7 6176.2 6220.1 6275.8 6281.0 6286.1 6111.6 6113.4 6117.1 6121.1 6121.1 6290.9 6299.8 6310.2 6311.1 6325.3 6063.5 6102.4 6152.9 6157.4 6162.3 05:59:34 INFO - PROCESS | 4545 | 05:59:34 INFO - PROCESS | 4545 | [#5] yui.html Cycles:180 Average:13645.93 Median:47756.78 stddev:16192.04 (33.9%) stddev-sans-first:16208.51 05:59:34 INFO - PROCESS | 4545 | Values: 751.2 824.3 831.9 835.6 857.4 13271.1 13435.9 13439.9 13443.6 13458.9 12149.3 12176.5 12178.3 12192.8 12651.3 799.2 807.0 807.1 807.3 807.4 800.3 813.9 816.4 817.4 817.5 850.2 852.6 852.9 853.1 853.2 848.3 849.1 850.1 850.1 850.5 623.4 625.5 625.8 627.6 627.7 10787.7 11111.6 12593.5 12629.3 13398.7 12246.0 12312.1 12366.4 12615.0 12858.8 9784.6 9802.8 9853.6 10068.9 10107.8 3600.7 3641.9 3646.6 3646.9 3657.0 46967.8 47433.0 47882.8 48628.5 48670.8 9794.5 9859.3 10133.6 10207.1 10267.5 18418.9 18429.2 18475.9 18497.4 18526.6 7083.2 7174.6 7175.7 7201.2 7628.4 4101.8 4110.2 4159.5 4224.1 4273.4 3000.9 3029.3 3033.7 3045.3 3048.2 530.2 545.4 549.3 554.4 559.9 541.3 599.8 607.9 634.1 658.9 7834.1 8160.5 8177.6 8180.5 8191.6 612.8 614.3 622.3 639.3 670.2 3786.8 3788.7 3818.3 3917.3 3925.5 56454.0 56941.1 58802.4 58961.7 59212.0 50360.2 51351.2 51486.0 51507.5 51702.2 45613.5 46402.0 46538.8 46876.8 46886.1 7681.5 7707.8 7824.6 8098.2 8679.4 34175.5 34259.3 35182.0 36998.6 37897.0 45836.5 45921.0 46746.0 47630.8 47995.5 11069.8 11178.6 11275.2 11367.1 11372.9 11663.8 11710.9 11849.1 11937.8 12096.3 10285.1 10523.8 10534.3 10689.4 10761.6 10006.8 10214.7 10504.0 10520.0 10738.8 10309.0 10326.1 10408.5 10451.3 10473.3 8704.0 8710.8 8887.3 9005.5 9011.7 7758.3 8063.0 8264.5 8612.8 9088.1 05:59:34 INFO - PROCESS | 4545 | -------- Summary: end -------- 05:59:34 INFO - PROCESS | 4545 | 05:59:35 INFO - TEST-INFO | 4545: exit 0 05:59:35 INFO - TEST-OK | dromaeo_css | took 1112664ms 05:59:35 INFO - TEST-START | kraken 05:59:35 INFO - operating with platform_type : linux_ 05:59:35 INFO - Initialising browser for kraken test... 05:59:35 INFO - TEST-INFO | started process 4736 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY3Nvql/profile http://localhost:56044/getInfo.html) 05:59:39 INFO - PROCESS | 4736 | __metrics Screen width/height:1600/1200 05:59:39 INFO - PROCESS | 4736 | colorDepth:24 05:59:39 INFO - PROCESS | 4736 | Browser inner width/height: 1024/697 05:59:39 INFO - PROCESS | 4736 | __metrics 05:59:39 INFO - PROCESS | 4736 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 05:59:39 INFO - PROCESS | 4736 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:59:40 INFO - TEST-INFO | 4736: exit 0 05:59:40 INFO - Browser initialized. 05:59:40 INFO - Running cycle 1/1 for kraken test... 05:59:40 INFO - TEST-INFO | started process 4817 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpY3Nvql/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:59:52 INFO - PROCESS | 4817 | RSS: Main: 149901312 05:59:52 INFO - PROCESS | 4817 | 05:59:55 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56044/tests/kraken/driver.html?testName=audio-beat-detection) 05:59:55 INFO - PROCESS | 4817 | RSS: Main: 185634816 05:59:55 INFO - PROCESS | 4817 | 05:59:58 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56044/tests/kraken/driver.html?testName=audio-dft) 05:59:58 INFO - PROCESS | 4817 | RSS: Main: 177270784 05:59:58 INFO - PROCESS | 4817 | 06:00:01 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56044/tests/kraken/driver.html?testName=audio-fft) 06:00:02 INFO - PROCESS | 4817 | RSS: Main: 161890304 06:00:02 INFO - PROCESS | 4817 | 06:00:04 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56044/tests/kraken/driver.html?testName=audio-oscillator) 06:00:05 INFO - PROCESS | 4817 | RSS: Main: 163241984 06:00:05 INFO - PROCESS | 4817 | 06:00:07 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56044/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:00:07 INFO - PROCESS | 4817 | RSS: Main: 164753408 06:00:07 INFO - PROCESS | 4817 | 06:00:10 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56044/tests/kraken/driver.html?testName=imaging-darkroom) 06:00:11 INFO - PROCESS | 4817 | RSS: Main: 166322176 06:00:11 INFO - PROCESS | 4817 | 06:00:14 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56044/tests/kraken/driver.html?testName=imaging-desaturate) 06:00:15 INFO - PROCESS | 4817 | RSS: Main: 166961152 06:00:15 INFO - PROCESS | 4817 | 06:00:18 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56044/tests/kraken/driver.html?testName=json-parse-financial) 06:00:18 INFO - PROCESS | 4817 | RSS: Main: 167075840 06:00:18 INFO - PROCESS | 4817 | 06:00:20 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56044/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:00:20 INFO - PROCESS | 4817 | RSS: Main: 176197632 06:00:20 INFO - PROCESS | 4817 | 06:00:22 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56044/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:00:23 INFO - PROCESS | 4817 | RSS: Main: 173887488 06:00:23 INFO - PROCESS | 4817 | 06:00:25 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56044/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:00:25 INFO - PROCESS | 4817 | RSS: Main: 183365632 06:00:25 INFO - PROCESS | 4817 | 06:00:28 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:00:28 INFO - PROCESS | 4817 | RSS: Main: 192028672 06:00:28 INFO - PROCESS | 4817 | 06:00:31 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:00:31 INFO - PROCESS | 4817 | RSS: Main: 191606784 06:00:31 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | Cycle 1(1): loaded http://localhost:56044/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56044/tests/kraken/driver.html?testName=ai-astar) 06:00:33 INFO - PROCESS | 4817 | RSS: Main: 248262656 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | __start_tp_report 06:00:33 INFO - PROCESS | 4817 | _x_x_mozilla_page_load 06:00:33 INFO - PROCESS | 4817 | _x_x_mozilla_page_load_details 06:00:33 INFO - PROCESS | 4817 | |i|pagename|runs| 06:00:33 INFO - PROCESS | 4817 | |0;ai-astar;110;110;104;109;110;111;100;109;109;109 06:00:33 INFO - PROCESS | 4817 | |1;audio-beat-detection;161;124;154;169;125;156;158;126;169;126 06:00:33 INFO - PROCESS | 4817 | |2;audio-dft;162;162;161;163;160;162;160;164;164;162 06:00:33 INFO - PROCESS | 4817 | |3;audio-fft;71;73;101;94;72;72;73;127;98;72 06:00:33 INFO - PROCESS | 4817 | |4;audio-oscillator;97;96;138;99;96;97;141;96;95;140 06:00:33 INFO - PROCESS | 4817 | |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;110;110 06:00:33 INFO - PROCESS | 4817 | |6;imaging-darkroom;147;146;145;146;145;145;145;145;145;145 06:00:33 INFO - PROCESS | 4817 | |7;imaging-desaturate;96;96;96;96;95;95;96;96;96;95 06:00:33 INFO - PROCESS | 4817 | |8;json-parse-financial;58;55;55;55;59;56;56;66;52;55 06:00:33 INFO - PROCESS | 4817 | |9;json-stringify-tinderbox;67;68;68;68;67;68;68;68;68;68 06:00:33 INFO - PROCESS | 4817 | |10;stanford-crypto-aes;80;90;82;84;91;82;82;82;83;85 06:00:33 INFO - PROCESS | 4817 | |11;stanford-crypto-ccm;115;114;112;125;116;115;114;113;115;127 06:00:33 INFO - PROCESS | 4817 | |12;stanford-crypto-pbkdf2;143;144;145;147;145;131;143;140;129;143 06:00:33 INFO - PROCESS | 4817 | |13;stanford-crypto-sha256-iterative;66;69;67;66;65;65;65;66;66;65 06:00:33 INFO - PROCESS | 4817 | __end_tp_report 06:00:33 INFO - PROCESS | 4817 | __start_cc_report 06:00:33 INFO - PROCESS | 4817 | _x_x_mozilla_cycle_collect,940 06:00:33 INFO - PROCESS | 4817 | __end_cc_report 06:00:33 INFO - PROCESS | 4817 | __startTimestamp1452866433719__endTimestamp 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | ------- Summary: start ------- 06:00:33 INFO - PROCESS | 4817 | Number of tests: 14 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.50 stddev:3.41 (3.1%) stddev-sans-first:3.55 06:00:33 INFO - PROCESS | 4817 | Values: 110.0 110.0 104.0 109.0 110.0 111.0 100.0 109.0 109.0 109.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:157.00 stddev:19.18 (12.2%) stddev-sans-first:19.64 06:00:33 INFO - PROCESS | 4817 | Values: 161.0 124.0 154.0 169.0 125.0 156.0 158.0 126.0 169.0 126.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.50 06:00:33 INFO - PROCESS | 4817 | Values: 162.0 162.0 161.0 163.0 160.0 162.0 160.0 164.0 164.0 162.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#3] audio-fft Cycles:10 Average:85.30 Median:72.50 stddev:19.03 (26.3%) stddev-sans-first:19.47 06:00:33 INFO - PROCESS | 4817 | Values: 71.0 73.0 101.0 94.0 72.0 72.0 73.0 127.0 98.0 72.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:96.00 stddev:20.86 (21.7%) stddev-sans-first:21.62 06:00:33 INFO - PROCESS | 4817 | Values: 97.0 96.0 138.0 99.0 96.0 97.0 141.0 96.0 95.0 140.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 06:00:33 INFO - PROCESS | 4817 | Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 110.0 110.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.00 stddev:0.70 (0.5%) stddev-sans-first:0.44 06:00:33 INFO - PROCESS | 4817 | Values: 147.0 146.0 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 06:00:33 INFO - PROCESS | 4817 | Values: 96.0 96.0 96.0 96.0 95.0 95.0 96.0 96.0 96.0 95.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.77 (6.7%) stddev-sans-first:3.97 06:00:33 INFO - PROCESS | 4817 | Values: 58.0 55.0 55.0 55.0 59.0 56.0 56.0 66.0 52.0 55.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#9] json-stringify-tinderbox Cycles:10 Average:67.80 Median:68.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 06:00:33 INFO - PROCESS | 4817 | Values: 67.0 68.0 68.0 68.0 67.0 68.0 68.0 68.0 68.0 68.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#10] stanford-crypto-aes Cycles:10 Average:84.10 Median:83.50 stddev:3.63 (4.4%) stddev-sans-first:3.54 06:00:33 INFO - PROCESS | 4817 | Values: 80.0 90.0 82.0 84.0 91.0 82.0 82.0 82.0 83.0 85.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#11] stanford-crypto-ccm Cycles:10 Average:116.60 Median:115.00 stddev:5.10 (4.4%) stddev-sans-first:5.38 06:00:33 INFO - PROCESS | 4817 | Values: 115.0 114.0 112.0 125.0 116.0 115.0 114.0 113.0 115.0 127.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:143.50 stddev:6.09 (4.2%) stddev-sans-first:6.42 06:00:33 INFO - PROCESS | 4817 | Values: 143.0 144.0 145.0 147.0 145.0 131.0 143.0 140.0 129.0 143.0 06:00:33 INFO - PROCESS | 4817 | 06:00:33 INFO - PROCESS | 4817 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:66.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 06:00:33 INFO - PROCESS | 4817 | Values: 66.0 69.0 67.0 66.0 65.0 65.0 65.0 66.0 66.0 65.0 06:00:33 INFO - PROCESS | 4817 | -------- Summary: end -------- 06:00:33 INFO - PROCESS | 4817 | 06:00:34 INFO - TEST-INFO | 4817: exit 0 06:00:34 INFO - TEST-OK | kraken | took 59094ms 06:00:34 INFO - TEST-START | v8_7 06:00:34 INFO - operating with platform_type : linux_ 06:00:34 INFO - Initialising browser for v8_7 test... 06:00:34 INFO - TEST-INFO | started process 5062 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9FlA3p/profile http://localhost:56044/getInfo.html) 06:00:38 INFO - PROCESS | 5062 | __metrics Screen width/height:1600/1200 06:00:38 INFO - PROCESS | 5062 | colorDepth:24 06:00:38 INFO - PROCESS | 5062 | Browser inner width/height: 1024/697 06:00:38 INFO - PROCESS | 5062 | __metrics 06:00:38 INFO - PROCESS | 5062 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 06:00:38 INFO - PROCESS | 5062 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:00:40 INFO - TEST-INFO | 5062: exit 0 06:00:40 INFO - Browser initialized. 06:00:40 INFO - Running cycle 1/1 for v8_7 test... 06:00:40 INFO - TEST-INFO | started process 5143 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9FlA3p/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:00:51 INFO - PROCESS | 5143 | RSS: Main: 150421504 06:00:51 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | Cycle 1(1): loaded http://localhost:56044/tests/v8_7/run.html (next: http://localhost:56044/tests/v8_7/run.html) 06:01:14 INFO - PROCESS | 5143 | RSS: Main: 562921472 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | __start_tp_report 06:01:14 INFO - PROCESS | 5143 | _x_x_mozilla_page_load 06:01:14 INFO - PROCESS | 5143 | _x_x_mozilla_page_load_details 06:01:14 INFO - PROCESS | 5143 | |i|pagename|runs| 06:01:14 INFO - PROCESS | 5143 | |0;Richards;169.98130205677376 06:01:14 INFO - PROCESS | 5143 | |1;DeltaBlue;190.94901661256444 06:01:14 INFO - PROCESS | 5143 | |2;Encrypt;279.56388034665923 06:01:14 INFO - PROCESS | 5143 | |3;Decrypt;5246.073298429319 06:01:14 INFO - PROCESS | 5143 | |4;RayTrace;1128.6681715575621 06:01:14 INFO - PROCESS | 5143 | |5;Earley;784.3137254901961 06:01:14 INFO - PROCESS | 5143 | |6;Boyer;12407.407407407407 06:01:14 INFO - PROCESS | 5143 | |7;RegExp;42208.333333333336 06:01:14 INFO - PROCESS | 5143 | |8;Splay;560.5381165919282 06:01:14 INFO - PROCESS | 5143 | |9;NavierStokes;4850.241545893719 06:01:14 INFO - PROCESS | 5143 | __end_tp_report 06:01:14 INFO - PROCESS | 5143 | __startTimestamp1452866474482__endTimestamp 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | ------- Summary: start ------- 06:01:14 INFO - PROCESS | 5143 | Number of tests: 10 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#0] Richards Cycles:1 Average:169.98 Median:169.98 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 170.0 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#1] DeltaBlue Cycles:1 Average:190.95 Median:190.95 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 190.9 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 279.6 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 5246.1 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#4] RayTrace Cycles:1 Average:1128.67 Median:1128.67 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 1128.7 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#5] Earley Cycles:1 Average:784.31 Median:784.31 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 784.3 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#6] Boyer Cycles:1 Average:12407.41 Median:12407.41 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 12407.4 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#7] RegExp Cycles:1 Average:42208.33 Median:42208.33 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 42208.3 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#8] Splay Cycles:1 Average:560.54 Median:560.54 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 560.5 06:01:14 INFO - PROCESS | 5143 | 06:01:14 INFO - PROCESS | 5143 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 06:01:14 INFO - PROCESS | 5143 | Values: 4850.2 06:01:14 INFO - PROCESS | 5143 | -------- Summary: end -------- 06:01:14 INFO - PROCESS | 5143 | 06:01:15 INFO - TEST-INFO | 5143: exit 0 06:01:15 INFO - TEST-OK | v8_7 | took 40728ms 06:01:15 INFO - SUITE-END | took 1212s 06:01:15 INFO - Completed test suite (00:20:12) 06:01:15 INFO - Working with test: dromaeo_css 06:01:15 INFO - Generating results file: dromaeo_css 06:01:15 INFO - Working with test: kraken 06:01:15 INFO - Generating results file: kraken 06:01:15 INFO - javascript benchmark 06:01:15 INFO - Working with test: v8_7 06:01:15 INFO - Generating results file: v8_7 06:01:15 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:01:15 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,35]] 06:01:15 INFO - process_Request line: dromaeo_css 6746.86 graph.html#tests=[[72,64,35]] 06:01:15 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:01:15 INFO - process_Request line: kraken 1494.20 graph.html#tests=[[232,64,35]] 06:01:15 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:01:15 INFO - process_Request line: v8_7 20058.98 graph.html#tests=[[230,64,35]] 06:01:15 INFO - RETURN: dromaeo_css: 6746.86 06:01:15 INFO - RETURN: kraken: 1494.20 06:01:15 INFO - RETURN: v8_7: 20058.98 06:01:15 INFO - javascript benchmark 06:01:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3018.8188708677476, 3052.908412747616, 3117.158367240845, 3127.249460129568, 3155.258514249151, 4919.212925931852, 5015.297858299841, 5042.722650254234, 5066.518680725325, 5093.26147708582, 4908.607311415087, 4985.027919555679, 5045.924311135336, 5156.716380599066, 5157.123289040863, 4579.793909274091, 4600.700954437959, 4622.560856718606, 4646.326282689008, 4737.857864264078, 4316.283949287414, 4634.559716826896, 4802.83190088347, 4817.22924332107, 4825.059113472857, 4468.731876087445, 4518.457785065781, 4536.432945881765, 4746.169420351424, 4807.855764327076, 4591.104734576759, 4595.126925884071, 4596.080783843245, 4602.0, 4612.077584483117, 4566.680332376735, 4572.1312950539295, 4574.794134263966, 4581.152486789954, 4584.12901548708, 4828.517148285178, 4836.85489435314, 4837.32277481153, 4846.345743324677, 4854.417469903634, 5347.224652425415, 5355.0, 5358.437364076754, 5358.973205133989, 5408.0, 5187.04039752647, 5276.12943864262, 5327.627066105374, 5366.812161574326, 5370.3287089113865, 4948.3072369868605, 5039.420466646346, 5048.848534543969, 5061.367329083864, 5095.821646242363, 5459.781608735606, 5460.31746031746, 5465.234867118606, 5465.863353416117, 5466.590005749585, 5141.177411614124, 5220.112580861262, 5276.445973172838, 5304.867378315573, 5401.810936617199, 5341.198820177005, 5346.91979620306, 5351.892962140735, 5359.1157459019605, 5360.437154098841, 5318.25544423781, 5318.946810531923, 5321.228421878806, 5326.121190003606, 5367.704776237267, 5199.428062913076, 5276.525112739795, 5310.840674779763, 5331.546818520469, 5401.135818269058, 4230.048239146167, 4242.787860606957, 4249.2563801334645, 4256.510501292391, 4288.4210631564965, 3785.2618739346112, 3803.3724435468393, 3825.1967086911504, 3836.7889766063136, 3864.574896761354, 4923.655344125948, 5003.824866129668, 5034.622403319766, 5058.519440653132, 5084.847454576368, 5350.27771250884, 5362.088444964365, 5372.7313634318125, 5379.67721936685, 5435.809746658848, 4843.636727245471, 4909.484504127086, 5006.74966251686, 5017.623678224148, 5022.949770502321, 4604.102200070954, 4641.628669706415, 4655.650826188049, 4674.906501869944, 4686.95313046872, 5443.482869127506, 5484.945150548523, 5491.697956612345, 5491.835244942578, 5521.475459831309, 5234.450382709761, 5299.655522391032, 5302.946970530245, 5304.549113325256, 5311.920321195263, 5471.863203419946, 5482.533984611353, 5490.396056433709, 5497.670139791625, 5548.667079975215, 5178.559822415137, 5201.791928322976, 5221.738913054408, 5227.947720522899, 5244.160934250502, 5191.76637051326, 5285.656432331886, 5298.841034768963, 5300.443453437333, 5301.920471192858, 5151.587872970078, 5166.147585648477, 5170.482951704799, 5175.301334319819, 5223.059849227176, 5187.507186817246, 5223.4515375884985, 5240.371155461369, 5244.134717771678, 5283.947160528345, 4977.751112444435, 5067.113255180255, 5153.072446959433, 5154.7938082476285, 5166.095933211598, 5203.089459344676, 5220.399654039834, 5222.033923724123, 5246.134387825966, 5246.606504512253, 5057.367829021372, 5060.569851562658, 5092.439831618445, 5094.388673359221, 5098.821541246187], "unit": "score", "name": "dojo.html", "value": 4947.057611970354}, {"lowerIsBetter": false, "replicates": [520.1261880041532, 535.9356877174739, 556.9136783798511, 588.7438964050639, 591.2107336705498, 27757.722422775765, 28477.0, 28540.143795686163, 28560.857195713994, 35194.64805351946, 38007.42988855169, 38594.614053859455, 38883.22233555334, 38901.61098389023, 38959.22081558367, 8536.0, 8791.73624791254, 8792.560371981408, 8793.0, 8799.164079412445, 7468.813279667997, 7474.0, 7490.588017659026, 7501.174870764239, 8491.532965686885, 10086.89913100867, 10253.384796912173, 10265.743356416075, 10287.537060832243, 10291.433971131584, 9836.213102951782, 9975.401475911396, 10003.14973227273, 10008.899911000906, 10017.749556261078, 10230.130438912627, 10412.375257484575, 10415.68752937413, 10417.947910260476, 10424.947875260576, 39094.0, 39638.60361396378, 39742.20515589672, 39753.80123099395, 39768.801155994326, 3191.0, 3277.2462333663393, 3447.620761716209, 3653.598104208535, 3856.1709232514863, 27353.31616709578, 28410.715892841014, 28707.42585148306, 29111.41777164466, 29358.266043348875, 3734.3464893643504, 3734.5705243897028, 3746.906327341811, 3756.3050835595227, 3923.391874259494, 263589.0, 270663.6466817673, 271294.0, 271616.0, 271620.0, 54499.0, 61441.69279153665, 62169.689151553954, 62274.68862655749, 62329.688351557954, 57592.4240757587, 67452.32547674558, 68119.20986716085, 68512.6574367125, 68566.0, 14640.341184646717, 14734.484293049692, 14736.631584210267, 14741.262936853114, 14835.703285934436, 12125.211861228992, 12146.271223726604, 12221.327826969424, 12239.0, 12254.387280635932, 20800.375988720363, 21129.154833806784, 21171.78828211729, 21178.0, 21204.15183392647, 8246.54643994586, 8509.872891518096, 8511.95744021276, 8557.957210214034, 8558.61486233121, 914.1818072824784, 931.7204838548408, 981.9901800981899, 1022.5858527296457, 1030.5568605499557, 26662.866685666446, 27190.73966801844, 27384.58923116155, 27398.315042124108, 27587.586186207223, 961.4183419031525, 1042.6663467690419, 1060.3531845574194, 1066.4401189375485, 1176.9470373833199, 14174.416930250087, 14175.362108705132, 14346.49787257441, 14372.209528475825, 14411.0, 401083.0, 406202.0, 407709.0, 408116.0, 408925.0, 53062.0, 53727.46272537303, 53760.19359709608, 53875.844966201694, 53946.0, 1300.232862611064, 1309.4173092973535, 1319.4722111155615, 1331.9876893560963, 1332.1074879830537, 26677.466450671265, 27007.86496067507, 27466.862665686545, 27794.0, 27854.0, 40913.79543102384, 41512.584874150874, 41513.50918944873, 41657.0, 42481.725548233604, 298618.0, 298691.0, 298748.0, 300447.0, 300695.0, 28173.859130704215, 28553.28616784597, 31871.043868683977, 32398.676013239565, 32973.83513082419, 37052.44421333736, 37254.627453725116, 37512.2497550042, 37623.81188094042, 38016.42975355427, 34488.13779655529, 34905.47641785426, 35012.649873501956, 37857.81071094627, 39170.60829391784, 32035.0, 34199.31601368009, 36208.637913621584, 37755.62244377521, 38379.808100959315, 33311.66688333086, 33550.32899342048, 33569.66430335665, 33777.15557111092, 33780.49329260014, 32070.67929320677, 32579.511307329936, 33126.33747324992, 33248.0, 33478.83260583682, 25288.62067069032, 31774.0, 31837.20406989844, 32159.14090309178, 33843.0], "unit": "score", "name": "ext.html", "value": 18575.94302184784}, {"lowerIsBetter": false, "replicates": [348.7907255646612, 357.6441440766438, 366.6278727092001, 367.94296883982975, 370.23731113905353, 13508.18950862949, 13953.930230348835, 15944.441944531929, 16174.0, 16983.320667173313, 14866.925665371686, 14968.775468367956, 15627.531174064768, 15661.530154095366, 15675.843241567582, 5113.5909127269915, 5227.163653815391, 5268.367795864501, 5285.6300058995885, 5302.125149350352, 3569.6078529373567, 3715.3126671565847, 3724.255148970203, 5107.795688172488, 5228.47715228478, 5247.553957913563, 5264.842054738345, 5268.710220937847, 5294.1529355303155, 5330.480812968305, 5454.809081682142, 5794.101914203306, 5806.65160090396, 5820.3121094882645, 5827.417258274181, 5038.496150384969, 5186.429492755794, 5190.896182076337, 5281.445448227919, 5301.469853014706, 11707.121965852595, 11919.523219071227, 12422.254664720145, 16522.339106435727, 20300.289489867784, 1987.791281915407, 2088.1229883448987, 2091.780363061887, 2120.7561130469885, 2139.721836161289, 8522.57387130641, 8889.111088891059, 9179.449233046038, 11015.779684406267, 13046.54337098197, 1715.5282297368199, 1792.6145878636025, 1799.595091104491, 1816.5640246340915, 1822.1526989949737, 55201.44798552043, 55627.16559251615, 55687.0, 56286.15570766442, 56446.717766410904, 10134.138598219233, 10169.694909152737, 10176.898231017743, 10193.23550733698, 10210.13213876814, 12883.227006379648, 12970.481180752664, 12979.286139262242, 12994.740105197843, 12996.67508312281, 7243.963780181065, 7321.11814893998, 7356.448266379936, 7368.0, 7386.224446433154, 6975.197852246955, 7076.716931322792, 7097.787066388017, 7128.893066604005, 7148.428125749928, 4324.9135017300105, 4412.3160910059, 4415.425994620743, 4454.354118652777, 4457.687961842705, 1725.3184991928117, 1778.119830683794, 1783.9108044597717, 1803.5220666523383, 1827.3421568235424, 867.9262262707614, 872.646578135856, 920.4109370003204, 1006.8489726541078, 1016.2885979814159, 13415.205961870235, 16169.59576010609, 16405.67188656244, 16470.247198648736, 16618.33526658944, 862.5126803356209, 888.2316795971567, 890.4523717913437, 902.566767951387, 902.9006809250977, 8026.638801253957, 9116.81766364669, 9265.629374825066, 9696.51517424126, 9724.465154416575, 410967.0, 415581.0, 461796.0, 540716.0, 543191.0, 70906.64546677233, 71403.0, 74331.25668743352, 75015.0, 75626.62186689032, 1117.4580328540815, 1118.8377685235432, 1119.5409881948362, 1138.1748232531513, 1143.1997601678859, 14059.437622495394, 14805.629859253604, 14975.775363369341, 15235.619109522351, 15310.31103600363, 30961.535576965915, 32478.35043299168, 33240.66759332376, 33567.832160840015, 34321.0, 40788.38817417682, 41382.37926431166, 41642.58357416508, 42058.7897060525, 42119.57880421279, 3076.415481058592, 3108.6114235720534, 5507.925954438846, 6851.526921711856, 7086.255943125898, 8206.425550211428, 11025.779484410106, 11351.0, 11367.317960922372, 11385.886141138482, 9539.189168920442, 9765.169960553432, 9809.16622087102, 10061.144802691853, 10124.088832005154, 9729.513524323615, 9855.86657534364, 10035.397876127456, 10189.23580731463, 10225.284230103822, 9303.0, 9656.95171524138, 9773.511324433608, 9978.60085596568, 10063.194944404577, 7129.500934934505, 7166.498345115792, 7251.709931602677, 7254.238304978113, 7263.237360077116, 7219.927800721925, 9690.612375505183, 10047.748806279902, 10217.795644087226, 10264.538095785856], "unit": "score", "name": "jquery.html", "value": 7863.6806225800665}, {"lowerIsBetter": false, "replicates": [1292.399034448981, 1441.9711605767884, 1454.440040584375, 1565.9564268629442, 1750.186163434003, 6804.863902721949, 7519.54882707038, 7670.808229794258, 7676.539407635546, 7704.807379815507, 7526.661300241489, 7739.845203095949, 7761.379089672827, 7771.261730135642, 7781.883271750914, 1973.2501649373219, 2017.5964807038577, 2228.699125618045, 2303.044236641796, 2329.906803727849, 2304.377817989142, 2310.607196776544, 2314.1206341590173, 2314.7222333320024, 2315.8610483370967, 2210.8231341492724, 2292.5071109711407, 2293.472501324696, 2295.690081838947, 2298.8505747126383, 2257.5146343536135, 2262.886855657219, 2272.363738153328, 2292.048799748119, 2294.678744975705, 2279.3048120323297, 2289.610766169755, 2296.9196078137184, 2308.676785250066, 2336.836421450499, 7614.048243969504, 7677.2322767723335, 7703.268189521987, 7705.383569314497, 7711.5758633275145, 4658.231391820379, 4749.0, 4785.138675038492, 4791.832285870013, 4815.879603009953, 2907.86914588844, 2946.6169397978124, 2995.4907665696664, 2996.595459612968, 3035.650900146489, 935.6397786852111, 953.323140570196, 971.4220039076808, 976.414151509096, 994.7612572982505, 10879.292845965067, 10880.455977201109, 10882.183836212316, 10898.291611045257, 10924.672259832218, 4345.760983145894, 4436.800343984464, 4444.911101777946, 4454.398656181439, 4478.39541661878, 9391.0, 9402.858957115648, 9408.341416100808, 9410.482423466776, 9417.293702972167, 4815.590674792682, 4827.686200396963, 4847.466778654345, 4847.684900481458, 4856.150173719656, 4346.7826608670075, 4358.6295164911335, 4401.2517871961845, 4405.052913623586, 4405.140997505519, 3394.253264281854, 3415.7438192135687, 3642.18050938542, 3709.5177626908867, 3760.0599850037493, 1164.4527072276016, 1176.2472017908544, 1185.9229150105216, 1193.9701507462382, 1206.3365149168098, 1057.2176589323844, 1058.1799105692996, 1206.9396530173456, 1227.147132742753, 1247.5321754342121, 6827.317268273232, 6860.725570977105, 6915.51591388598, 6917.688704008231, 7364.521306115085, 1059.1209296284067, 1081.7566047639375, 1089.9019088282093, 1090.1006669497538, 1118.681175864891, 5756.107803290497, 5767.8558036049435, 5818.854528636818, 5844.415558444207, 5845.1232315153065, 9273.443593384418, 9432.528373581294, 9586.37031704612, 9588.952055239819, 9599.42403455795, 9451.574679139456, 9460.716178514518, 9469.573869175903, 9583.520823958774, 9670.0, 7201.675924583406, 7336.193018767931, 7346.081739782528, 7417.925820741832, 7421.257874212535, 7128.4653650977425, 7179.425645948416, 7200.135983681992, 7207.8558428832175, 7238.674259658223, 8412.158784121539, 8466.153384661484, 8541.316694664287, 8611.569421529024, 8619.91380086191, 8694.08712085222, 8755.387122901591, 8900.06549312313, 8921.15249051339, 9033.548322583976, 6937.340952609494, 6954.721811127498, 7018.087648605649, 7034.472414568825, 7043.471739619446, 6497.25281592604, 6599.7360105595235, 7249.782506524602, 7489.70041198346, 7507.662155203138, 6875.4155896749335, 6957.721691132298, 7040.436765058886, 7058.470614703815, 7074.080369551925, 6837.213720422215, 6907.585544867324, 6911.032455456139, 6920.204176519765, 6941.82645433848, 6687.264400915993, 6739.191297044386, 6783.728650853911, 6795.72817087311, 6796.150481189851, 5920.2895652521975, 6058.757649694139, 6075.0, 6077.513798896166, 6078.45293923549, 6345.4923606112325, 6556.246031706415, 6561.1470508833545, 6562.2125344957, 6567.704453299518], "unit": "score", "name": "mootools.html", "value": 4472.51564612253}, {"lowerIsBetter": false, "replicates": [336.80970251807724, 341.3633573385635, 341.82396066025984, 346.0604458894102, 351.62025012985964, 5795.971020144893, 5916.792912248066, 5947.4944629706415, 5951.702414879255, 5956.672383018932, 5720.713964301779, 5822.883542329151, 5844.064949608053, 5886.146508756238, 5889.970550147254, 4594.402727645418, 4595.058013107313, 4595.609373203265, 4596.862094137181, 4604.539546045402, 4388.210122178007, 4470.955290447087, 4481.350204220386, 4578.473475550304, 4587.357769912215, 4472.373867658531, 4473.865784026484, 4479.753613551254, 4504.62608904284, 4506.52681468446, 4484.103179364108, 4502.482214545336, 4516.458025037, 4548.545145485458, 4566.1780879441685, 4023.1350259694013, 4026.45642838216, 4027.2952233359047, 4036.7577945323374, 4042.1309418474875, 5494.120940649477, 5631.211630371751, 5652.3217213934595, 5661.7735290588325, 5668.404817494186, 5253.106971814763, 5255.1329030709885, 5263.6578622389425, 5264.842054738364, 5267.920981185285, 5937.732802023919, 6306.432421082079, 6307.05394190875, 6311.93688063118, 6319.336469670664, 4179.185058913513, 4251.383549385322, 4313.460817397825, 4317.892052698676, 4322.978385108055, 6361.0, 6530.346965303432, 6534.967325163391, 6543.770968016097, 6544.9672751635935, 4441.71128876622, 4450.710703804242, 4463.687541872037, 4465.441819772528, 4474.686771925999, 4456.688031837805, 4503.437070366204, 4528.728276303433, 4530.728156310566, 4545.522720114406, 5202.271681964528, 5206.947930520646, 5213.400458947193, 5216.4522725114075, 5236.24074509194, 6243.562950593415, 6268.122462855204, 6274.874502509924, 6277.121203031579, 6283.7800676976085, 1586.7143914095343, 1604.5667669729341, 1605.4300723243314, 1607.3490236454254, 1613.0, 1073.0985971783582, 1075.800976819291, 1085.696005118568, 1091.1325496230515, 1103.100972707241, 5966.254218222723, 5970.283565972111, 5975.910361344583, 5977.163197152402, 5981.760729570856, 6482.57863238888, 6483.448906842971, 6486.059521369375, 6494.350564943468, 6497.675116244169, 5908.409159084057, 5914.733836977346, 5916.822495325061, 5917.615355001911, 5928.703564821828, 3431.0736101252523, 3531.7351198660203, 3541.1678255609913, 3542.946855797165, 3543.7519373644113, 6848.0, 6852.657367131624, 6854.6229957351825, 6857.519973601899, 6857.691403886837, 6643.667816609151, 6678.332166783282, 6684.4318232950745, 6694.665266736741, 6707.49693772969, 6621.966890165519, 6804.829879253059, 6818.8636227276165, 6819.31806819324, 6824.41992430639, 6271.78048768291, 6411.166548348685, 6537.05212744159, 6543.443807276435, 6547.345265473415, 6282.340354262737, 6459.935400645933, 6512.54412191161, 6520.315366886409, 6539.378759017885, 6776.559523630948, 6782.796516104525, 6788.389044985975, 6790.830229244309, 6794.83012924661, 4279.293916503742, 4455.108978204437, 4501.887452813706, 4504.63962882962, 4506.098780243899, 6398.264199617103, 6464.967675161783, 6468.708908099053, 6478.352164783484, 6485.902711459237, 6276.278228003838, 6288.182536270256, 6289.088082228142, 6297.96851015742, 6323.747050117944, 6176.227971503562, 6220.129181914626, 6275.780347687809, 6280.9685951569945, 6286.057091436322, 6111.563782511195, 6113.358097399709, 6117.143599896107, 6121.112438696453, 6121.143039974496, 6290.874182516415, 6299.76358392764, 6310.242770867525, 6311.075122087807, 6325.304216536269, 6063.454289114001, 6102.359252278625, 6152.938470615416, 6157.353477884937, 6162.26052873658], "unit": "score", "name": "prototype.html", "value": 4746.971718445967}, {"lowerIsBetter": false, "replicates": [751.2037240525044, 824.3405275779375, 831.9334453243741, 835.561330301592, 857.3526987124721, 13271.137376070561, 13435.932820335896, 13439.865601343983, 13443.596692099229, 13458.865411345883, 12149.271043737383, 12176.452059657337, 12178.269303841776, 12192.81710774339, 12651.304178270191, 799.2007992007992, 807.0315621254489, 807.0758980966818, 807.2734538914995, 807.3621838747382, 800.3157300508069, 813.8657121574932, 816.4081041245109, 817.3951276055735, 817.4972391978949, 850.1795767084762, 852.5694524265238, 852.910444403338, 853.0701535326493, 853.2320911179926, 848.2874385516196, 849.0914721248267, 850.056437354536, 850.1328644782318, 850.4727069217095, 623.3797371615226, 625.5183508698323, 625.8185126313364, 627.5857933763695, 627.6830200748639, 10787.730306742316, 11111.611093611766, 12593.496260149583, 12629.305388203646, 13398.732025359439, 12246.0, 12312.076594255466, 12366.381680915918, 12615.0, 12858.807117893239, 9784.559694813679, 9802.754931126708, 9853.556589953469, 10068.899311006942, 10107.848382274271, 3600.747947643666, 3641.9074277716577, 3646.5988741238443, 3646.9270614587826, 3656.981715091434, 46967.76516117398, 47433.0, 47882.802929926685, 48628.513714863104, 48670.75664621654, 9794.461304628314, 9859.26055545837, 10133.64532241368, 10207.081362677394, 10267.537960791782, 18418.907905460386, 18429.170687319103, 18475.90762046208, 18497.445076647724, 18526.629467410577, 7083.220845706968, 7174.569525828467, 7175.712971481083, 7201.207867134611, 7628.389728821681, 4101.753894766264, 4110.157417729359, 4159.542450330461, 4224.091820258659, 4273.358996150602, 3000.8799648014274, 3029.2881172924344, 3033.726964573199, 3045.284358175827, 3048.222703210667, 530.247049190151, 545.4082320682026, 549.3270743339457, 554.365251786702, 559.862833605761, 541.2557733116964, 599.7570983751588, 607.8784243151388, 634.1110041579474, 658.9439897608661, 7834.099078605919, 8160.510369377737, 8177.632006559719, 8180.46826956246, 8191.590420479071, 612.8467883029243, 614.3181069013481, 622.2564035977055, 639.2776162935945, 670.24597328006, 3786.753860999026, 3788.6969042476535, 3818.3317919364, 3917.334053210904, 3925.4896863408144, 56454.0, 56941.14588281179, 58802.41197588055, 58961.70519147377, 59212.0, 50360.24459633108, 51351.229731554056, 51486.0, 51507.48492515102, 51702.22446663303, 45613.543864561594, 46401.99999999932, 46538.76730616325, 46876.7656161717, 46886.06227875423, 7681.539107653559, 7707.807304817425, 7824.569648669378, 8098.190180981855, 8679.392442529215, 34175.487367689006, 34259.314813704084, 35182.0, 36998.63001369952, 37897.0, 45836.54163458323, 45921.0, 46746.0, 47630.761846190544, 47995.520044800505, 11069.83395249088, 11178.552857885594, 11275.15436342294, 11367.090632749525, 11372.886271137182, 11663.825042624538, 11710.88289117132, 11849.111316651459, 11937.761244774882, 12096.274223546616, 10285.125764310118, 10523.789524209626, 10534.315269507457, 10689.412082335235, 10761.569537218424, 10006.849897251692, 10214.693559193236, 10504.0, 10520.0, 10738.83891741609, 10309.0, 10326.122279606017, 10408.47957602132, 10451.268411211142, 10473.26687131924, 8703.95648021756, 8710.780490731177, 8887.333449991405, 9005.504697241715, 9011.684591039282, 7758.340541053848, 8063.0, 8264.462809917337, 8612.827743445221, 9088.136627020422], "unit": "score", "name": "yui.html", "value": 6147.2156543851115}], "name": "dromaeo_css", "value": 6746.8596962767415}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 110.0, 104.0, 109.0, 110.0, 111.0, 100.0, 109.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 108.1}, {"lowerIsBetter": true, "replicates": [161.0, 124.0, 154.0, 169.0, 125.0, 156.0, 158.0, 126.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 163.0, 160.0, 162.0, 160.0, 164.0, 164.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [71.0, 73.0, 101.0, 94.0, 72.0, 72.0, 73.0, 127.0, 98.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 138.0, 99.0, 96.0, 97.0, 141.0, 96.0, 95.0, 140.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.4}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [58.0, 55.0, 55.0, 55.0, 59.0, 56.0, 56.0, 66.0, 52.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.8}, {"lowerIsBetter": true, "replicates": [80.0, 90.0, 82.0, 84.0, 91.0, 82.0, 82.0, 82.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.1}, {"lowerIsBetter": true, "replicates": [115.0, 114.0, 112.0, 125.0, 116.0, 115.0, 114.0, 113.0, 115.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.6}, {"lowerIsBetter": true, "replicates": [143.0, 144.0, 145.0, 147.0, 145.0, 131.0, 143.0, 140.0, 129.0, 143.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [66.0, 69.0, 67.0, 66.0, 65.0, 65.0, 65.0, 66.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.0}], "name": "kraken", "value": 1494.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.98130205677376], "unit": "score", "name": "Richards", "value": 207.68166599999995}, {"lowerIsBetter": false, "replicates": [190.94901661256444], "unit": "score", "name": "DeltaBlue", "value": 346.2599660000002}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1128.6681715575621], "unit": "score", "name": "RayTrace", "value": 655.6302539999998}, {"lowerIsBetter": false, "replicates": [784.3137254901961], "unit": "score", "name": "Earley", "value": 849.7403250000002}, {"lowerIsBetter": false, "replicates": [12407.407407407407], "unit": "score", "name": "Boyer", "value": 53.71492835820899}, {"lowerIsBetter": false, "replicates": [42208.333333333336], "unit": "score", "name": "RegExp", "value": 21.583060217176715}, {"lowerIsBetter": false, "replicates": [560.5381165919282], "unit": "score", "name": "Splay", "value": 145.37994400000002}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 20058.979657720247}]} 06:01:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,35]]", "result": "20058.98"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,35]]", "result": "1494.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,35]]", "result": "6746.86"}}} 06:01:15 INFO - Return code: 0 06:01:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 06:01:15 INFO - # TBPL SUCCESS # 06:01:15 INFO - Running post-action listener: _resource_record_post_action 06:01:15 INFO - Running post-run listener: _resource_record_post_run 06:01:17 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 539246592; Read time: 0; Write time: 482304 06:01:17 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 237154304; Read time: 0; Write time: 238308 06:01:17 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 302092288; Read time: 0; Write time: 243996 06:01:17 INFO - Running post-run listener: _upload_blobber_files 06:01:17 INFO - Blob upload gear active. 06:01:17 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 06:01:17 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 06:01:17 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', 'Fx-Team', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 06:01:17 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 Fx-Team -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 06:01:17 INFO - (blobuploader) - INFO - Open directory for files ... 06:01:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:01:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:01:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:18 INFO - (blobuploader) - INFO - Done attempting. 06:01:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 06:01:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:01:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:01:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:01:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:01:19 INFO - (blobuploader) - INFO - Done attempting. 06:01:19 INFO - (blobuploader) - INFO - Iteration through files over. 06:01:19 INFO - Return code: 0 06:01:19 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 06:01:19 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 06:01:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3a2f3f0a2e7ae00d7e664ef233d5255e403377c4d79201666ef402b7431db543eb1791ac8bb539dbe93504a4880757970399e9727ae3f3570463d084ca805f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca8c31df72a8f13765fc68a4aca689eece78189b9d2d605802feaa1f5a03947dcb1de05a362b09ce86f885c82d756faf380e386728c5f124b170d6bd6da42c74"} 06:01:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 06:01:19 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 06:01:19 INFO - Contents: 06:01:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3a2f3f0a2e7ae00d7e664ef233d5255e403377c4d79201666ef402b7431db543eb1791ac8bb539dbe93504a4880757970399e9727ae3f3570463d084ca805f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca8c31df72a8f13765fc68a4aca689eece78189b9d2d605802feaa1f5a03947dcb1de05a362b09ce86f885c82d756faf380e386728c5f124b170d6bd6da42c74"} 06:01:19 INFO - Copying logs to upload dir... 06:01:19 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1271.205995 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2016-01-15 06:01:18.668364) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 06:01:18.672730) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f3a2f3f0a2e7ae00d7e664ef233d5255e403377c4d79201666ef402b7431db543eb1791ac8bb539dbe93504a4880757970399e9727ae3f3570463d084ca805f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca8c31df72a8f13765fc68a4aca689eece78189b9d2d605802feaa1f5a03947dcb1de05a362b09ce86f885c82d756faf380e386728c5f124b170d6bd6da42c74"} build_url:https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011349 build_url: 'https://queue.taskcluster.net/v1/task/TFJpTB9YRAOCJCgIghZbAA/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/Fx-Team/sha512/f3a2f3f0a2e7ae00d7e664ef233d5255e403377c4d79201666ef402b7431db543eb1791ac8bb539dbe93504a4880757970399e9727ae3f3570463d084ca805f2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ca8c31df72a8f13765fc68a4aca689eece78189b9d2d605802feaa1f5a03947dcb1de05a362b09ce86f885c82d756faf380e386728c5f124b170d6bd6da42c74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-15 06:01:18.701645) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:01:18.701988) ========= 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=b5f16d05e5ea93ddf675e67e000001bf-1452865202.853379-110472642 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-15 06:01:18.785987) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 06:01:18.786323) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-15 06:01:18.786646) ========= ========= Total master_lag: 0.23 =========