builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-058 starttime: 1449267407.92 results: success (0) buildid: 20151204120710 builduid: 9e620a53ffa24408b8e3a369a5b97f93 revision: 695a52aa5554b191bd6d533f6842edf5ad228e8e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:47.921497) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:47.921943) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:47.922265) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.005742 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:47.944193) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:47.944511) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:47.957457) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:47.957775) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.006731) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.007036) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.007400) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.007667) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-04 14:16:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.6M=0s 2015-12-04 14:16:48 (46.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.198372 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.218175) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.218482) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017313 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.268225) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.268598) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 695a52aa5554b191bd6d533f6842edf5ad228e8e --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 695a52aa5554b191bd6d533f6842edf5ad228e8e --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=e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-04 14:16:49,074 truncating revision to first 12 chars 2015-12-04 14:16:49,075 Setting DEBUG logging. 2015-12-04 14:16:49,075 attempt 1/10 2015-12-04 14:16:49,075 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/695a52aa5554?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-04 14:16:49,342 unpacking tar archive at: mozilla-aurora-695a52aa5554/testing/mozharness/ program finished with exit code 0 elapsedTime=0.530546 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.811688) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.812033) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.819779) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.820065) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-04 14:16:48.820500) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-12-04 14:16:48.820784) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:16:49 INFO - MultiFileLogger online at 20151204 14:16:49 in /builds/slave/test-pgo 14:16:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 14:16:49 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 14:16:49 INFO - {'append_to_log': False, 14:16:49 INFO - 'base_work_dir': '/builds/slave/test-pgo', 14:16:49 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 14:16:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 14:16:49 INFO - 'branch': 'Mozilla-Aurora', 14:16:49 INFO - 'buildbot_json_path': 'buildprops.json', 14:16:49 INFO - 'config_files': ('talos/linux_config.py',), 14:16:49 INFO - 'default_actions': ('clobber', 14:16:49 INFO - 'read-buildbot-config', 14:16:49 INFO - 'download-and-extract', 14:16:49 INFO - 'populate-webroot', 14:16:49 INFO - 'create-virtualenv', 14:16:49 INFO - 'install', 14:16:49 INFO - 'run-tests'), 14:16:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:16:49 INFO - 'download_minidump_stackwalk': True, 14:16:49 INFO - 'download_symbols': 'ondemand', 14:16:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:16:49 INFO - 'tooltool.py': '/tools/tooltool.py', 14:16:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:16:49 INFO - '/tools/misc-python/virtualenv.py')}, 14:16:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:16:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:16:49 INFO - 'installer_path': 'installer.exe', 14:16:49 INFO - 'log_level': 'info', 14:16:49 INFO - 'log_name': 'talos', 14:16:49 INFO - 'log_to_console': True, 14:16:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:16:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:16:49 INFO - 'opt_config_files': (), 14:16:49 INFO - 'pip_index': False, 14:16:49 INFO - 'sps_profile': False, 14:16:49 INFO - 'sps_profile_interval': 0, 14:16:49 INFO - 'suite': 'dromaeojs-e10s', 14:16:49 INFO - 'system_bits': '64', 14:16:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:16:49 INFO - 'title': 'talos-linux64-ix-058', 14:16:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:16:49 INFO - 'use_talos_json': True, 14:16:49 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 14:16:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:16:49 INFO - 'work_dir': 'build'} 14:16:49 INFO - ##### 14:16:49 INFO - ##### Running clobber step. 14:16:49 INFO - ##### 14:16:49 INFO - Running pre-action listener: _resource_record_pre_action 14:16:49 INFO - Running main action method: clobber 14:16:49 INFO - rmtree: /builds/slave/test-pgo/build 14:16:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 14:16:50 INFO - Running post-action listener: _resource_record_post_action 14:16:50 INFO - ##### 14:16:50 INFO - ##### Running read-buildbot-config step. 14:16:50 INFO - ##### 14:16:50 INFO - Running pre-action listener: _resource_record_pre_action 14:16:50 INFO - Running main action method: read_buildbot_config 14:16:50 INFO - Using buildbot properties: 14:16:50 INFO - { 14:16:50 INFO - "properties": { 14:16:50 INFO - "buildnumber": 13, 14:16:50 INFO - "product": "firefox", 14:16:50 INFO - "script_repo_revision": "production", 14:16:50 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 14:16:50 INFO - "repository": "", 14:16:50 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 14:16:50 INFO - "buildid": "20151204120710", 14:16:50 INFO - "slavename": "talos-linux64-ix-058", 14:16:50 INFO - "pgo_build": "True", 14:16:50 INFO - "basedir": "/builds/slave/test-pgo", 14:16:50 INFO - "project": "", 14:16:50 INFO - "platform": "ubuntu64_hw", 14:16:50 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:16:50 INFO - "slavebuilddir": "test", 14:16:50 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 14:16:50 INFO - "branch": "mozilla-aurora", 14:16:50 INFO - "repo_path": "releases/mozilla-aurora", 14:16:50 INFO - "stage_platform": "linux64-pgo", 14:16:50 INFO - "builduid": "9e620a53ffa24408b8e3a369a5b97f93", 14:16:50 INFO - "revision": "695a52aa5554b191bd6d533f6842edf5ad228e8e" 14:16:50 INFO - }, 14:16:50 INFO - "sourcestamp": { 14:16:50 INFO - "repository": "", 14:16:50 INFO - "hasPatch": false, 14:16:50 INFO - "project": "", 14:16:50 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 14:16:50 INFO - "changes": [ 14:16:50 INFO - { 14:16:50 INFO - "category": null, 14:16:50 INFO - "files": [ 14:16:50 INFO - { 14:16:50 INFO - "url": null, 14:16:50 INFO - "name": "https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2" 14:16:50 INFO - } 14:16:50 INFO - ], 14:16:50 INFO - "repository": "", 14:16:50 INFO - "rev": "695a52aa5554b191bd6d533f6842edf5ad228e8e", 14:16:50 INFO - "who": "jmathies@mozilla.com", 14:16:50 INFO - "when": 1449267191, 14:16:50 INFO - "number": 6746186, 14:16:50 INFO - "comments": "Bug 1230238 - Disable e10s by default on Aurora for a period of non-e10s testing before it goes to Beta. r=jimm, a=ritu", 14:16:50 INFO - "project": "", 14:16:50 INFO - "at": "Fri 04 Dec 2015 14:13:11", 14:16:50 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 14:16:50 INFO - "revlink": "", 14:16:50 INFO - "properties": [ 14:16:50 INFO - [ 14:16:50 INFO - "buildid", 14:16:50 INFO - "20151204120710", 14:16:50 INFO - "Change" 14:16:50 INFO - ], 14:16:50 INFO - [ 14:16:50 INFO - "builduid", 14:16:50 INFO - "9e620a53ffa24408b8e3a369a5b97f93", 14:16:50 INFO - "Change" 14:16:50 INFO - ], 14:16:50 INFO - [ 14:16:50 INFO - "pgo_build", 14:16:50 INFO - "True", 14:16:50 INFO - "Change" 14:16:50 INFO - ] 14:16:50 INFO - ], 14:16:50 INFO - "revision": "695a52aa5554b191bd6d533f6842edf5ad228e8e" 14:16:50 INFO - } 14:16:50 INFO - ], 14:16:50 INFO - "revision": "695a52aa5554b191bd6d533f6842edf5ad228e8e" 14:16:50 INFO - } 14:16:50 INFO - } 14:16:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2. 14:16:50 INFO - Running post-action listener: _resource_record_post_action 14:16:50 INFO - ##### 14:16:50 INFO - ##### Running download-and-extract step. 14:16:50 INFO - ##### 14:16:50 INFO - Running pre-action listener: _resource_record_pre_action 14:16:50 INFO - Running main action method: download_and_extract 14:16:50 INFO - mkdir: /builds/slave/test-pgo/build/tests 14:16:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:50 INFO - https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 14:16:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/test_packages.json 14:16:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/test_packages.json 14:16:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 14:16:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 14:16:51 INFO - Downloaded 1302 bytes. 14:16:51 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 14:16:51 INFO - Using the following test package requirements: 14:16:51 INFO - {u'common': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 14:16:51 INFO - u'cppunittest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:51 INFO - u'firefox-44.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 14:16:51 INFO - u'jittest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:51 INFO - u'jsshell-linux-x86_64.zip'], 14:16:51 INFO - u'mochitest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:51 INFO - u'firefox-44.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 14:16:51 INFO - u'mozbase': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 14:16:51 INFO - u'reftest': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:51 INFO - u'firefox-44.0a2.en-US.linux-x86_64.reftest.tests.zip'], 14:16:51 INFO - u'talos': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:51 INFO - u'firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'], 14:16:51 INFO - u'web-platform': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:51 INFO - u'firefox-44.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 14:16:51 INFO - u'webapprt': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'], 14:16:51 INFO - u'xpcshell': [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 14:16:51 INFO - u'firefox-44.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 14:16:51 INFO - Downloading packages: [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:51 INFO - https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 14:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 14:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 14:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:52 INFO - Downloaded 22571505 bytes. 14:16:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:16:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 14:16:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:16:53 INFO - Return code: 0 14:16:53 INFO - Downloading packages: [u'firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:16:53 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')]} 14:16:53 INFO - https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:16:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 14:16:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 14:16:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 14:16:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:16:54 INFO - Downloaded 22571505 bytes. 14:16:54 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 14:16:54 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip 14:16:54 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 14:16:55 INFO - Return code: 0 14:16:55 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')]} 14:16:55 INFO - https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:16:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 14:16:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 14:16:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 14:16:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:16:56 INFO - Downloaded 11131970 bytes. 14:16:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 14:16:56 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip 14:16:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 14:16:57 INFO - Return code: 0 14:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:16:57 INFO - https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:16:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 14:16:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 14:16:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 14:16:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:16:58 INFO - Downloaded 56767328 bytes. 14:16:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 14:16:58 INFO - mkdir: /builds/slave/test-pgo/properties 14:16:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 14:16:58 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 14:16:58 INFO - Contents: 14:16:58 INFO - build_url:https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 14:16:58 INFO - Running post-action listener: _resource_record_post_action 14:16:58 INFO - Running post-action listener: set_extra_try_arguments 14:16:58 INFO - ##### 14:16:58 INFO - ##### Running populate-webroot step. 14:16:58 INFO - ##### 14:16:58 INFO - Running pre-action listener: _resource_record_pre_action 14:16:58 INFO - Running main action method: populate_webroot 14:16:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:16:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:16:58 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 14:16:58 INFO - '../fennec_ids.txt'], 14:16:58 INFO - 'tests': ['tcheck2']}, 14:16:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:16:58 INFO - '--tppagecycles', 14:16:58 INFO - '7'], 14:16:58 INFO - 'tests': ['tsvgm']}}, 14:16:58 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 14:16:58 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:16:58 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:16:58 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 14:16:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:16:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'tests': ['damp', 'tps']}, 14:16:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['damp', 'tps']}, 14:16:58 INFO - 'g3': {'tests': ['dromaeo_dom']}, 14:16:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:16:58 INFO - 'other': {'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other-e10s': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other_l64': {'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'other_nol64': {'tests': ['a11yr', 14:16:58 INFO - 'ts_paint', 14:16:58 INFO - 'tpaint', 14:16:58 INFO - 'sessionrestore', 14:16:58 INFO - 'sessionrestore_no_auto_restore']}, 14:16:58 INFO - 'svgr': {'tests': ['tsvgx', 14:16:58 INFO - 'tsvgr_opacity', 14:16:58 INFO - 'tart', 14:16:58 INFO - 'tscrollx', 14:16:58 INFO - 'cart']}, 14:16:58 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['tsvgx', 14:16:58 INFO - 'tsvgr_opacity', 14:16:58 INFO - 'tart', 14:16:58 INFO - 'tscrollx', 14:16:58 INFO - 'cart']}, 14:16:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'tests': ['tp5o']}, 14:16:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--e10s'], 14:16:58 INFO - 'tests': ['tp5o']}, 14:16:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--xperf_path', 14:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:58 INFO - 'tests': ['tp5n']}, 14:16:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:16:58 INFO - 'talos_options': ['--e10s', 14:16:58 INFO - '--xperf_path', 14:16:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:16:58 INFO - 'tests': ['tp5n']}}, 14:16:58 INFO - 'talos.zip': {'path': '', 14:16:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:16:58 INFO - Running post-action listener: _resource_record_post_action 14:16:58 INFO - ##### 14:16:58 INFO - ##### Running create-virtualenv step. 14:16:58 INFO - ##### 14:16:58 INFO - Running pre-action listener: _resource_record_pre_action 14:16:58 INFO - Running main action method: create_virtualenv 14:16:58 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 14:16:58 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 14:16:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 14:16:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:16:58 INFO - Using real prefix '/usr' 14:16:58 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 14:16:59 INFO - Installing distribute.............................................................................................................................................................................................done. 14:17:01 INFO - Installing pip.................done. 14:17:01 INFO - Return code: 0 14:17:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 14:17: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')]} 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:01 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 0x7f19f0a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', '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 14:17:01 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 14:17:01 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 14:17:01 INFO - Using env: {'DISPLAY': ':0', 14:17:01 INFO - 'HOME': '/home/cltbld', 14:17:01 INFO - 'LANG': 'en_US.UTF-8', 14:17:01 INFO - 'LANGUAGE': 'en_US:en', 14:17:01 INFO - 'LOGNAME': 'cltbld', 14:17:01 INFO - 'MAIL': '/var/mail/cltbld', 14:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:01 INFO - 'MOZ_NO_REMOTE': '1', 14:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:01 INFO - 'NO_EM_RESTART': '1', 14:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:01 INFO - 'SHELL': '/bin/bash', 14:17:01 INFO - 'SHLVL': '1', 14:17:01 INFO - 'TERM': 'linux', 14:17:01 INFO - 'TMOUT': '86400', 14:17:01 INFO - 'USER': 'cltbld', 14:17:01 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:01 INFO - '_': '/tools/buildbot/bin/python'} 14:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:01 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 14:17:01 INFO - Cleaning up... 14:17:01 INFO - Return code: 0 14:17:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 14:17: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')]} 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:01 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 0x7f19f0a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', '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 14:17:01 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 14:17:01 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 14:17:01 INFO - Using env: {'DISPLAY': ':0', 14:17:01 INFO - 'HOME': '/home/cltbld', 14:17:01 INFO - 'LANG': 'en_US.UTF-8', 14:17:01 INFO - 'LANGUAGE': 'en_US:en', 14:17:01 INFO - 'LOGNAME': 'cltbld', 14:17:01 INFO - 'MAIL': '/var/mail/cltbld', 14:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:01 INFO - 'MOZ_NO_REMOTE': '1', 14:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:01 INFO - 'NO_EM_RESTART': '1', 14:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:01 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:01 INFO - 'SHELL': '/bin/bash', 14:17:01 INFO - 'SHLVL': '1', 14:17:01 INFO - 'TERM': 'linux', 14:17:01 INFO - 'TMOUT': '86400', 14:17:01 INFO - 'USER': 'cltbld', 14:17:01 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:01 INFO - '_': '/tools/buildbot/bin/python'} 14:17:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:01 INFO - Downloading/unpacking psutil>=0.7.1 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:03 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 14:17:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 14:17:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 14:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:03 INFO - Installing collected packages: psutil 14:17:03 INFO - Running setup.py install for psutil 14:17:03 INFO - building 'psutil._psutil_linux' extension 14:17:03 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 14:17:03 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 14:17:03 INFO - building 'psutil._psutil_posix' extension 14:17:03 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 14:17:03 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 14:17:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:17:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:17:03 INFO - Successfully installed psutil 14:17:03 INFO - Cleaning up... 14:17:03 INFO - Return code: 0 14:17:03 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 14:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:03 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--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 0x7f19f0a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', '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 14:17:03 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 14:17:03 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 14:17:03 INFO - Using env: {'DISPLAY': ':0', 14:17:03 INFO - 'HOME': '/home/cltbld', 14:17:03 INFO - 'LANG': 'en_US.UTF-8', 14:17:03 INFO - 'LANGUAGE': 'en_US:en', 14:17:03 INFO - 'LOGNAME': 'cltbld', 14:17:03 INFO - 'MAIL': '/var/mail/cltbld', 14:17:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:03 INFO - 'MOZ_NO_REMOTE': '1', 14:17:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:03 INFO - 'NO_EM_RESTART': '1', 14:17:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:03 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:03 INFO - 'SHELL': '/bin/bash', 14:17:03 INFO - 'SHLVL': '1', 14:17:03 INFO - 'TERM': 'linux', 14:17:03 INFO - 'TMOUT': '86400', 14:17:03 INFO - 'USER': 'cltbld', 14:17:03 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:03 INFO - '_': '/tools/buildbot/bin/python'} 14:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:04 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:05 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:17:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 14:17:05 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:17:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:17:05 INFO - Installing collected packages: mozsystemmonitor 14:17:05 INFO - Running setup.py install for mozsystemmonitor 14:17:05 INFO - Successfully installed mozsystemmonitor 14:17:05 INFO - Cleaning up... 14:17:06 INFO - Return code: 0 14:17:06 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 14:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:17:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:06 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f19f0a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', '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 14:17:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 14:17:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:17:06 INFO - Using env: {'DISPLAY': ':0', 14:17:06 INFO - 'HOME': '/home/cltbld', 14:17:06 INFO - 'LANG': 'en_US.UTF-8', 14:17:06 INFO - 'LANGUAGE': 'en_US:en', 14:17:06 INFO - 'LOGNAME': 'cltbld', 14:17:06 INFO - 'MAIL': '/var/mail/cltbld', 14:17:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:06 INFO - 'MOZ_NO_REMOTE': '1', 14:17:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:06 INFO - 'NO_EM_RESTART': '1', 14:17:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:06 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:06 INFO - 'SHELL': '/bin/bash', 14:17:06 INFO - 'SHLVL': '1', 14:17:06 INFO - 'TERM': 'linux', 14:17:06 INFO - 'TMOUT': '86400', 14:17:06 INFO - 'USER': 'cltbld', 14:17:06 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:06 INFO - '_': '/tools/buildbot/bin/python'} 14:17:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:06 INFO - Downloading/unpacking blobuploader==1.2.4 14:17:06 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 14:17:06 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 14:17:06 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 14:17:06 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 14:17:06 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 14:17:06 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 14:17:07 INFO - Downloading blobuploader-1.2.4.tar.gz 14:17:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 14:17:07 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:17:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:17:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 14:17:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 14:17:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:08 INFO - Downloading docopt-0.6.1.tar.gz 14:17:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 14:17:08 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 14:17:08 INFO - Installing collected packages: blobuploader, requests, docopt 14:17:08 INFO - Running setup.py install for blobuploader 14:17:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:17:08 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 14:17:08 INFO - Running setup.py install for requests 14:17:09 INFO - Running setup.py install for docopt 14:17:09 INFO - Successfully installed blobuploader requests docopt 14:17:09 INFO - Cleaning up... 14:17:09 INFO - Return code: 0 14:17:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17: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')]} 14:17:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17: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')]} 14:17:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:09 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 0x7f19f0a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', '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 14:17:09 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 14:17:09 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 14:17:09 INFO - Using env: {'DISPLAY': ':0', 14:17:09 INFO - 'HOME': '/home/cltbld', 14:17:09 INFO - 'LANG': 'en_US.UTF-8', 14:17:09 INFO - 'LANGUAGE': 'en_US:en', 14:17:09 INFO - 'LOGNAME': 'cltbld', 14:17:09 INFO - 'MAIL': '/var/mail/cltbld', 14:17:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:09 INFO - 'MOZ_NO_REMOTE': '1', 14:17:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:09 INFO - 'NO_EM_RESTART': '1', 14:17:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:09 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:09 INFO - 'SHELL': '/bin/bash', 14:17:09 INFO - 'SHLVL': '1', 14:17:09 INFO - 'TERM': 'linux', 14:17:09 INFO - 'TMOUT': '86400', 14:17:09 INFO - 'USER': 'cltbld', 14:17:09 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:09 INFO - '_': '/tools/buildbot/bin/python'} 14:17:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:09 INFO - Running setup.py (path:/tmp/pip-JuiKfU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:09 INFO - Running setup.py (path:/tmp/pip-UJ6kOf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:09 INFO - Running setup.py (path:/tmp/pip-fRmlkC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:09 INFO - Running setup.py (path:/tmp/pip-jiuktY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:09 INFO - Running setup.py (path:/tmp/pip-6G5otQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:09 INFO - Running setup.py (path:/tmp/pip-d1Q889-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:09 INFO - Running setup.py (path:/tmp/pip-M0z7gl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:09 INFO - Running setup.py (path:/tmp/pip-lpAvHO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:10 INFO - Running setup.py (path:/tmp/pip-m0PDd2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:10 INFO - Running setup.py (path:/tmp/pip-0qSEUm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:10 INFO - Running setup.py (path:/tmp/pip-kJWeGz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:10 INFO - Running setup.py (path:/tmp/pip-mf2VzE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:10 INFO - Running setup.py (path:/tmp/pip-hFSqIS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:10 INFO - Running setup.py (path:/tmp/pip-YjSCgJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:10 INFO - Running setup.py (path:/tmp/pip-Ub7YiW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:10 INFO - Running setup.py (path:/tmp/pip-WT5h8M-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:10 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:10 INFO - Running setup.py (path:/tmp/pip-l9OpYb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:17:10 INFO - Running setup.py install for manifestparser 14:17:10 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 14:17:10 INFO - Running setup.py install for mozcrash 14:17:10 INFO - Running setup.py install for mozdebug 14:17:10 INFO - Running setup.py install for mozdevice 14:17:11 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozfile 14:17:11 INFO - Running setup.py install for mozhttpd 14:17:11 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozinfo 14:17:11 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozInstall 14:17:11 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozleak 14:17:11 INFO - Running setup.py install for mozlog 14:17:11 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for moznetwork 14:17:11 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 14:17:11 INFO - Running setup.py install for mozprocess 14:17:11 INFO - Running setup.py install for mozprofile 14:17:12 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 14:17:12 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 14:17:12 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 14:17:12 INFO - Running setup.py install for mozrunner 14:17:12 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 14:17:12 INFO - Running setup.py install for mozscreenshot 14:17:12 INFO - Running setup.py install for moztest 14:17:12 INFO - Running setup.py install for mozversion 14:17:12 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 14:17:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:17:12 INFO - Cleaning up... 14:17:12 INFO - Return code: 0 14:17:12 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17:12 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')]} 14:17:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:12 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')]} 14:17:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:12 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 0x7f19f0a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', '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 14:17:12 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 14:17:12 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 14:17:12 INFO - Using env: {'DISPLAY': ':0', 14:17:12 INFO - 'HOME': '/home/cltbld', 14:17:12 INFO - 'LANG': 'en_US.UTF-8', 14:17:12 INFO - 'LANGUAGE': 'en_US:en', 14:17:12 INFO - 'LOGNAME': 'cltbld', 14:17:12 INFO - 'MAIL': '/var/mail/cltbld', 14:17:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:12 INFO - 'MOZ_NO_REMOTE': '1', 14:17:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:12 INFO - 'NO_EM_RESTART': '1', 14:17:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:12 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:12 INFO - 'SHELL': '/bin/bash', 14:17:12 INFO - 'SHLVL': '1', 14:17:12 INFO - 'TERM': 'linux', 14:17:12 INFO - 'TMOUT': '86400', 14:17:12 INFO - 'USER': 'cltbld', 14:17:12 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:12 INFO - '_': '/tools/buildbot/bin/python'} 14:17:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:12 INFO - Running setup.py (path:/tmp/pip-_3FKzm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 14:17:12 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)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:12 INFO - Running setup.py (path:/tmp/pip-jaCGJW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 14:17:12 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)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:12 INFO - Running setup.py (path:/tmp/pip-esmXkj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 14:17:12 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)) 14:17:12 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:12 INFO - Running setup.py (path:/tmp/pip-B4ga48-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 14:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.46 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:13 INFO - Running setup.py (path:/tmp/pip-epETzI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:13 INFO - Running setup.py (path:/tmp/pip-veYs7P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:13 INFO - Running setup.py (path:/tmp/pip-q8fLZZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 14:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.8 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:13 INFO - Running setup.py (path:/tmp/pip-LJEpCE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:13 INFO - Running setup.py (path:/tmp/pip-cr0z1W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:13 INFO - Running setup.py (path:/tmp/pip-2Clu6R-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 14:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:13 INFO - Running setup.py (path:/tmp/pip-WwaEue-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:13 INFO - Running setup.py (path:/tmp/pip-O4TW7H-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:13 INFO - Running setup.py (path:/tmp/pip-u8GEfm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 14:17:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:13 INFO - Running setup.py (path:/tmp/pip-23ucGY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:13 INFO - Running setup.py (path:/tmp/pip-2qa149-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:13 INFO - Running setup.py (path:/tmp/pip-GA_aSb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 14:17:13 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)) 14:17:13 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:13 INFO - Running setup.py (path:/tmp/pip-mY9nIr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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)) 14:17:13 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:13 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.46->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 14:17:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:17:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:17:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:17:15 INFO - Downloading blessings-1.5.1.tar.gz 14:17:15 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 14:17:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 14:17:15 INFO - Installing collected packages: blessings 14:17:15 INFO - Running setup.py install for blessings 14:17:15 INFO - Successfully installed blessings 14:17:15 INFO - Cleaning up... 14:17:15 INFO - Return code: 0 14:17:15 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 14:17:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:17:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:17:16 INFO - Reading from file tmpfile_stdout 14:17:16 INFO - Current package versions: 14:17:16 INFO - argparse == 1.2.1 14:17:16 INFO - blessings == 1.5.1 14:17:16 INFO - blobuploader == 1.2.4 14:17:16 INFO - docopt == 0.6.1 14:17:16 INFO - manifestparser == 1.1 14:17:16 INFO - mozInstall == 1.12 14:17:16 INFO - mozcrash == 0.16 14:17:16 INFO - mozdebug == 0.1 14:17:16 INFO - mozdevice == 0.46 14:17:16 INFO - mozfile == 1.2 14:17:16 INFO - mozhttpd == 0.7 14:17:16 INFO - mozinfo == 0.8 14:17:16 INFO - mozleak == 0.1 14:17:16 INFO - mozlog == 3.0 14:17:16 INFO - moznetwork == 0.27 14:17:16 INFO - mozprocess == 0.22 14:17:16 INFO - mozprofile == 0.27 14:17:16 INFO - mozrunner == 6.11 14:17:16 INFO - mozscreenshot == 0.1 14:17:16 INFO - mozsystemmonitor == 0.0 14:17:16 INFO - moztest == 0.7 14:17:16 INFO - mozversion == 1.4 14:17:16 INFO - psutil == 3.1.1 14:17:16 INFO - requests == 1.2.3 14:17:16 INFO - wsgiref == 0.1.2 14:17:16 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 14:17:16 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')]} 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:16 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')]} 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:16 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 0x7f19f0a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', '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 14:17:16 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 14:17:16 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 14:17:16 INFO - Using env: {'DISPLAY': ':0', 14:17:16 INFO - 'HOME': '/home/cltbld', 14:17:16 INFO - 'LANG': 'en_US.UTF-8', 14:17:16 INFO - 'LANGUAGE': 'en_US:en', 14:17:16 INFO - 'LOGNAME': 'cltbld', 14:17:16 INFO - 'MAIL': '/var/mail/cltbld', 14:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:16 INFO - 'MOZ_NO_REMOTE': '1', 14:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:16 INFO - 'NO_EM_RESTART': '1', 14:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:16 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:16 INFO - 'SHELL': '/bin/bash', 14:17:16 INFO - 'SHLVL': '1', 14:17:16 INFO - 'TERM': 'linux', 14:17:16 INFO - 'TMOUT': '86400', 14:17:16 INFO - 'USER': 'cltbld', 14:17:16 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:16 INFO - '_': '/tools/buildbot/bin/python'} 14:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:16 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 1)) 14:17:16 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 2)) 14:17:16 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 3)) 14:17:16 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 4)) 14:17:16 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 5)) 14:17:16 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 6)) 14:17:16 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 7)) 14:17:16 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 8)) 14:17:16 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.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:17:16 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 3)) 14:17:16 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.0->mozcrash>=0.15->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 14:17:16 INFO - Cleaning up... 14:17:16 INFO - Return code: 0 14:17:16 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 14:17:16 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')]} 14:17:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:16 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')]} 14:17:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:16 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 0x7f19f0a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', '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 14:17:16 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 14:17:16 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 14:17:16 INFO - Using env: {'DISPLAY': ':0', 14:17:16 INFO - 'HOME': '/home/cltbld', 14:17:16 INFO - 'LANG': 'en_US.UTF-8', 14:17:16 INFO - 'LANGUAGE': 'en_US:en', 14:17:16 INFO - 'LOGNAME': 'cltbld', 14:17:16 INFO - 'MAIL': '/var/mail/cltbld', 14:17:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:16 INFO - 'MOZ_NO_REMOTE': '1', 14:17:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:16 INFO - 'NO_EM_RESTART': '1', 14:17:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:16 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:16 INFO - 'SHELL': '/bin/bash', 14:17:16 INFO - 'SHLVL': '1', 14:17:16 INFO - 'TERM': 'linux', 14:17:16 INFO - 'TMOUT': '86400', 14:17:16 INFO - 'USER': 'cltbld', 14:17:16 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:16 INFO - '_': '/tools/buildbot/bin/python'} 14:17:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:16 INFO - Downloading/unpacking jsonschema 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 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 14:17:16 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 14:17:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:17:18 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 14:17:18 INFO - Downloading/unpacking functools32 (from jsonschema) 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 INFO - Downloading functools32-3.2.3-2.tar.gz 14:17:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 14:17:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 14:17:18 INFO - warning: no files found matching '*.txt' 14:17:18 INFO - no previously-included directories found matching 'build' 14:17:18 INFO - no previously-included directories found matching 'dist' 14:17:18 INFO - no previously-included directories found matching '.git*' 14:17:18 INFO - Installing collected packages: jsonschema, functools32 14:17:18 INFO - Running setup.py install for functools32 14:17:18 INFO - warning: no files found matching '*.txt' 14:17:18 INFO - no previously-included directories found matching 'build' 14:17:18 INFO - no previously-included directories found matching 'dist' 14:17:18 INFO - no previously-included directories found matching '.git*' 14:17:18 INFO - Successfully installed jsonschema functools32 14:17:18 INFO - Cleaning up... 14:17:18 INFO - Return code: 0 14:17:18 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 14:17:18 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')]} 14:17:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:17:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:18 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')]} 14:17:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:17:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:17:18 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 0x7f19f0a94f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138a450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, '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': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', '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 14:17:18 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 14:17:18 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 14:17:18 INFO - Using env: {'DISPLAY': ':0', 14:17:18 INFO - 'HOME': '/home/cltbld', 14:17:18 INFO - 'LANG': 'en_US.UTF-8', 14:17:18 INFO - 'LANGUAGE': 'en_US:en', 14:17:18 INFO - 'LOGNAME': 'cltbld', 14:17:18 INFO - 'MAIL': '/var/mail/cltbld', 14:17:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:18 INFO - 'MOZ_NO_REMOTE': '1', 14:17:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:18 INFO - 'NO_EM_RESTART': '1', 14:17:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:18 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:18 INFO - 'SHELL': '/bin/bash', 14:17:18 INFO - 'SHLVL': '1', 14:17:18 INFO - 'TERM': 'linux', 14:17:18 INFO - 'TMOUT': '86400', 14:17:18 INFO - 'USER': 'cltbld', 14:17:18 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:18 INFO - '_': '/tools/buildbot/bin/python'} 14:17:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:17:18 INFO - Downloading/unpacking flake8 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:18 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 14:17:20 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:17:20 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 14:17:20 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:17:20 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 14:17:20 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:20 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 14:17:21 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 14:17:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 14:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:21 INFO - no previously-included directories found matching 'docs/_build' 14:17:21 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:17:21 INFO - Running setup.py install for pep8 14:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:17:21 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:17:21 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:17:21 INFO - no previously-included directories found matching 'docs/_build' 14:17:21 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 14:17:21 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:17:21 INFO - Cleaning up... 14:17:21 INFO - Return code: 0 14:17:21 INFO - Running post-action listener: _resource_record_post_action 14:17:21 INFO - Running post-action listener: _start_resource_monitoring 14:17:21 INFO - Starting resource monitoring. 14:17:21 INFO - ##### 14:17:21 INFO - ##### Running install step. 14:17:21 INFO - ##### 14:17:21 INFO - Running pre-action listener: _resource_record_pre_action 14:17:21 INFO - Running main action method: install 14:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 14:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 14:17:21 INFO - Reading from file tmpfile_stdout 14:17:21 INFO - Detecting whether we're running mozinstall >=1.0... 14:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 14:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 14:17:21 INFO - Reading from file tmpfile_stdout 14:17:21 INFO - Output received: 14:17:21 INFO - Usage: mozinstall [options] installer 14:17:21 INFO - Options: 14:17:21 INFO - -h, --help show this help message and exit 14:17:21 INFO - -d DEST, --destination=DEST 14:17:21 INFO - Directory to install application into. [default: 14:17:21 INFO - "/builds/slave/test-pgo"] 14:17:21 INFO - --app=APP Application being installed. [default: firefox] 14:17:21 INFO - mkdir: /builds/slave/test-pgo/build/application 14:17:21 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 14:17:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 14:17:36 INFO - Reading from file tmpfile_stdout 14:17:36 INFO - Output received: 14:17:36 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 14:17:36 INFO - Running post-action listener: _resource_record_post_action 14:17:36 INFO - ##### 14:17:36 INFO - ##### Running run-tests step. 14:17:36 INFO - ##### 14:17:36 INFO - Running pre-action listener: _resource_record_pre_action 14:17:36 INFO - Running main action method: run_tests 14:17:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 14:17:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 14:17:36 INFO - Python 2.7.3 14:17:36 INFO - Return code: 0 14:17:36 INFO - grabbing minidump binary from tooltool 14:17: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')]} 14:17:36 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 0x141ca50>, '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 0x1388550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13889e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 14:17:36 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 14:17:36 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 14:17:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:17:36 INFO - Return code: 0 14:17:36 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 14:17:36 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 14:17:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 14:17:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 14:17:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 14:17:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 14:17:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 14:17:37 INFO - Return code: 0 14:17:37 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 14:17:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --webServer localhost 14:17:37 INFO - Using env: {'DISPLAY': ':0', 14:17:37 INFO - 'HOME': '/home/cltbld', 14:17:37 INFO - 'LANG': 'en_US.UTF-8', 14:17:37 INFO - 'LANGUAGE': 'en_US:en', 14:17:37 INFO - 'LOGNAME': 'cltbld', 14:17:37 INFO - 'MAIL': '/var/mail/cltbld', 14:17:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:17:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 14:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:17:37 INFO - 'MOZ_NO_REMOTE': '1', 14:17:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 14:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:17:37 INFO - 'NO_EM_RESTART': '1', 14:17:37 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 14:17:37 INFO - 'PWD': '/builds/slave/test-pgo', 14:17:37 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 14:17:37 INFO - 'SHELL': '/bin/bash', 14:17:37 INFO - 'SHLVL': '1', 14:17:37 INFO - 'TERM': 'linux', 14:17:37 INFO - 'TMOUT': '86400', 14:17:37 INFO - 'USER': 'cltbld', 14:17:37 INFO - 'XDG_SESSION_COOKIE': 'e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373', 14:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:17:37 INFO - '_': '/tools/buildbot/bin/python'} 14:17:37 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--webServer', 'localhost'] with output_timeout 3600 14:17:37 INFO - mozversion INFO | application_buildid: 20151204120710 14:17:37 INFO - mozversion INFO | application_changeset: 695a52aa5554b191bd6d533f6842edf5ad228e8e 14:17:37 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 14:17:37 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:17:37 INFO - mozversion INFO | application_name: Firefox 14:17:37 INFO - mozversion INFO | application_remotingname: firefox-dev 14:17:37 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:17:37 INFO - mozversion INFO | application_vendor: Mozilla 14:17:37 INFO - mozversion INFO | application_version: 44.0a2 14:17:37 INFO - mozversion INFO | platform_buildid: 20151204120710 14:17:37 INFO - mozversion INFO | platform_changeset: 695a52aa5554b191bd6d533f6842edf5ad228e8e 14:17:37 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 14:17:37 INFO - mozversion INFO | platform_version: 44.0a2 14:17:37 INFO - 2015-12-04 14:17:37,578 DEBUG : using testdate: 1449267457 14:17:37 INFO - 2015-12-04 14:17:37,578 DEBUG : actual date: 1449267457 14:17:37 INFO - 2015-12-04 14:17:37,586 INFO : starting webserver on 'localhost:36746' 14:17:37 INFO - 2015-12-04 14:17:37,587 INFO : Starting test suite talos-linux64-ix-058.e 14:17:37 INFO - 2015-12-04 14:17:37,588 INFO : Starting test dromaeo_css 14:17:37 INFO - 2015-12-04 14:17:37,588 DEBUG : operating with platform_type : linux_ 14:17:37 INFO - 2015-12-04 14:17:37,588 INFO : Initialising browser for dromaeo_css test... 14:17:37 INFO - 2015-12-04 14:17:37,605 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpELpxsj/profile http://localhost:36746/getInfo.html 14:17:42 INFO - 2015-12-04 14:17:42,154 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:17:42 INFO - 2015-12-04 14:17:42,154 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:17:42 INFO - 2015-12-04 14:17:42,154 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:17:42 INFO - 2015-12-04 14:17:42,154 DEBUG : BROWSER_OUTPUT: __metrics 14:17:43 INFO - 2015-12-04 14:17:43,101 INFO : Browser initialized. 14:17:43 INFO - 2015-12-04 14:17:43,102 INFO : Running cycle 1/1 for dromaeo_css test... 14:17:43 INFO - 2015-12-04 14:17:43,102 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpELpxsj/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:17:54 INFO - 2015-12-04 14:17:54,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 133808128 14:17:54 INFO - 2015-12-04 14:17:54,818 DEBUG : BROWSER_OUTPUT: 14:18:44 INFO - 2015-12-04 14:18:44,481 DEBUG : BROWSER_OUTPUT: 1449267524477 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] 14:20:52 INFO - 2015-12-04 14:20:52,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36746/tests/dromaeo/cssquery-ext.html) 14:20:53 INFO - 2015-12-04 14:20:53,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 137736192 14:20:53 INFO - 2015-12-04 14:20:53,224 DEBUG : BROWSER_OUTPUT: 14:23:54 INFO - 2015-12-04 14:23:54,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/dromaeo/cssquery-ext.html (next: http://localhost:36746/tests/dromaeo/cssquery-jquery.html) 14:23:55 INFO - 2015-12-04 14:23:55,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 136785920 14:23:55 INFO - 2015-12-04 14:23:55,531 DEBUG : BROWSER_OUTPUT: 14:26:57 INFO - 2015-12-04 14:26:57,093 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36746/tests/dromaeo/cssquery-mootools.html) 14:26:57 INFO - 2015-12-04 14:26:57,682 DEBUG : BROWSER_OUTPUT: RSS: Main: 135135232 14:26:57 INFO - 2015-12-04 14:26:57,682 DEBUG : BROWSER_OUTPUT: 14:29:59 INFO - 2015-12-04 14:29:59,261 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36746/tests/dromaeo/cssquery-prototype.html) 14:29:59 INFO - 2015-12-04 14:29:59,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 136597504 14:29:59 INFO - 2015-12-04 14:29:59,847 DEBUG : BROWSER_OUTPUT: 14:33:02 INFO - 2015-12-04 14:33:02,003 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36746/tests/dromaeo/cssquery-yui.html) 14:33:02 INFO - 2015-12-04 14:33:02,609 DEBUG : BROWSER_OUTPUT: RSS: Main: 136028160 14:33:02 INFO - 2015-12-04 14:33:02,609 DEBUG : BROWSER_OUTPUT: 14:36:04 INFO - 2015-12-04 14:36:04,590 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/dromaeo/cssquery-yui.html (next: http://localhost:36746/tests/dromaeo/cssquery-dojo.html) 14:36:04 INFO - 2015-12-04 14:36:04,834 DEBUG : BROWSER_OUTPUT: RSS: Main: 138690560 14:36:04 INFO - 2015-12-04 14:36:04,834 DEBUG : BROWSER_OUTPUT: 14:36:04 INFO - 2015-12-04 14:36:04,835 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:36:04 INFO - 2015-12-04 14:36:04,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:36:04 INFO - 2015-12-04 14:36:04,835 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:36:04 INFO - 2015-12-04 14:36:04,835 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:36:04 INFO - 2015-12-04 14:36:04,836 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3372.15696075981;3444.707199888009;3450.2236996675733;3473.409520381535;3479.0432631026474;5746.482816546515;5753.108268218432;5782.566307526931;5786.942130578693;5809.128630705396;5741.62679425837;5805.506531944779;5818.476337129658;5825.563082768798;5825.592208545403;5256.132738098209;5298.47015298469;5369.463053694639;5371.167469042305;5394.1908713692865;5182.766775495112;5215.660982036175;5226.360687852629;5243.554297884684;5249;5301.390340110879;5322.0952438085615;5408.864778380553;5430.104032834578;5430.212619170218;5402.459754024605;5418.106012507931;5418.485243901842;5426.077566813651;5450.31871016123;5111.872203194913;5204.115300398941;5334.0665383557725;5359.1425371940695;5417.674939503642;5481.725913704338;5519.917201241985;5571.387147413781;5608.298962629671;5648.63283886546;6068.120122582245;6102.7864024759365;6108.3280839107665;6112.052631842072;6134.570580059398;6055.27336719592;6118.449339559416;6119.533019689815;6174.197354343906;6187.381261873777;5832.008558545015;5849.268841394825;5857.736401861884;5862.267216597926;5883.470487656089;6290.55966082379;6362.618242905348;6376.234851817719;6390.7218556288;6391.392817682313;6061.787837425669;6063;6158.630482171084;6168.1056246843955;6195.1636529068;6218.689065546704;6259.499240060784;6283;6290.496760259169;6342.23893132827;6222.28443728977;6243;6248.4064013918605;6265.373462653698;6271.905921411182;5995.940040599626;6103.755849766048;6120.599512025043;6252.624842509464;6271.372862713783;4676.976615116902;4682.953170468251;4685.250359942393;4698.389209402756;4704.294355846582;4137.089840235143;4267.594578515036;4275.743455392686;4288.614024737789;4297;5871.031279838779;5953.732082056318;6042.456178943916;6043.425874541911;6096.268447786294;6303.369663033752;6306.905396419057;6319.24169099711;6336.809895703136;6339.651319177397;5822.301323841166;5969.164316995624;5986;6000.33996260411;6016.42843929826;5356;5415.323084614423;5457.61796674229;5461.781528738886;5482.396936337;6430.678466076677;6446.548741588138;6475.287718350977;6495.220573531112;6495.253045899782;6072.666003369681;6156.199694039746;6165.0444181152;6380;6409.519286053472;6277.654728989949;6278.748850045947;6379.7129129190225;6395.232572091193;6401.647909364843;6247.718852651732;6289.213848268966;6310.5898116622275;6315.368463153648;6336.398042185985;6119.44924956756;6203.410675985774;6437.227532696106;6439.098526206241;6446;6126.663033533198;6221.4089661482085;6247.5001999839;6263.185785847811;6276.811695649138;6214.40963108504;6223.471004964447;6228.28374736893;6234.376562343729;6243.063540468966;5866.50134738535;5972.492338151305;5992.340842507408;6104.9389506106145;6112.72492737819;6144.324124346229;6150.138980542638;6170.598911070766;6208.0998255253635;6232.252129744278;6064.666443345658;6065.514758819372;6065.54508411862;6072.514198864169;6083.087536869505 14:36:04 INFO - 2015-12-04 14:36:04,837 DEBUG : BROWSER_OUTPUT: |1;ext.html;589.8142085243148;630.9116723658688;637.5664548107287;650.1807722269939;700.9193942696588;35518.46722299165;43472.347914781305;43705;43886.56113438865;43941;48623.27065094026;48831;48982.26526602104;49121.75439122808;49395.259071113964;9125.04187060359;9300.697902293685;9330.440173589606;9345;9401.952990235039;9116.954415227914;9186;9231.6307347706;9242.214411775007;9249.861252081224;9119.635214591408;9148.954255228748;9251.861222081674;9257.16685498305;9296.070392960717;9050.32122590805;9186.219171370441;9229.907700922971;9259.58331875064;9264.212541933945;9111;9184.17342439177;9222.95388523053;9274.536273186313;9284.860727089099;44772;45094.77452612716;45248.77375613134;45278.54721452776;45312.77343613261;3284.3267130238246;3361.9495707564406;3390.4744764561533;3525.6121826599056;4167.729097608646;33540.1614959628;33988.66011339879;34105.6589434105;34188.658113418795;34253.143671408165;3840.5967373425947;3888.2223555289056;3938.8424463021443;3951.7826519541413;3991.6435507961824;322240;323851;323913;326111;327748;47406.28890566644;47410.5258947413;66796;66889.3311066883;67080;46450.303245451345;46483.535164648594;46618.76690616593;46656.5334346659;46733;14805.629859253604;14888.106713597002;14896.851031489763;14911.776323355158;14941.40234390634;12290.446929888176;12322.137450378388;12349.567765128177;12359;12416.503339866485;16191.595210119842;16286.185690715654;16361.427350042692;16401.261943212583;16408.67182656364;6100.542459315569;6160.229971253593;6172.166757487771;6181.443670069715;6184.969075154685;947.9004704505927;1024.6516184497307;1030.5465595138114;1033;1133.3653154233655;35444.64555354465;36055.066936876596;36082.097947550996;36381.72663956749;36961;1063.5373612478597;1108.922375433712;1166.6150170443734;1207.1911819081236;1234.3457967277357;16552.33790648385;16674.83325166733;16802.747958780627;16900.40848570319;17046.82953170477;479703;522639;526498;530082;533864;60938.69530652319;62924.68537657282;63034.36965630377;63055;63225;1443.3793468808303;1464;1472.8379878213389;1473.2412807404196;1478.2313197137644;32041.51937720983;32287.35425291434;32317;32392.83803580967;33097.338053239284;50207.49792502028;50327;50601;50612.49387506225;50845.74577127091;364737;369308;369622;369791;370548;35217.295654087284;35570;35607;35826.92519224427;35882;46558;47206;55340.72329638326;55544.72227638836;55788.72105639446;40251;40401.39397909093;40840;41558.37662435006;42026.78986605047;41437.378439324035;41689.37465938074;41813.989239047325;41991.7900410496;42304.57695423006;40865.59134408618;40977.79511102426;41031.38452923149;41165;41221.79389103036;34396.65603343934;35376.823115884254;36062.63937360698;36334.636653633126;36503.26993460063;28005.859970700018;28705.712942870305;28864.711352886203;28935.276618084717;29367.265818354714 14:36:04 INFO - 2015-12-04 14:36:04,838 DEBUG : BROWSER_OUTPUT: |2;jquery.html;371.6822117089888;372.9794861282629;373.5125661012378;376.2906920454945;378.8503541101266;12454.875451245485;13609.979251556124;17889.999999999985;20988.475288117806;21086.156553737834;11875.16873818833;13328.200307981504;13416.865831341684;13561.11852729572;13850.307484625779;4920.335754673118;4944.381952255968;4973.278874563186;5000.949990500103;5015.623828212881;4867.68360056597;4982.651214414975;4984.277279794428;4989.525995030466;5134.229865520165;4835.371401717772;4878.4145902491755;4892.5596696297325;4896.804127834882;4931.679440836352;5190.92213616796;5211.452797456251;5213.504717051874;5238.47615238475;5238.685678859261;4426.9778651106535;4453.688241823073;4455.353973673799;4459.910801783946;4462.174497717932;15314.387424503118;15553.30010149546;15768.81733869953;15832.92083539575;15964.281607327699;2090.4773806548365;2114.112072929358;2151.5266641339035;2167.5556510915226;2314.8958296876513;10831.891681083167;10876.347419154798;10952.397618130999;11028.669139925814;11271.436428178558;1780.6171673090219;1819.5451137215696;1829.6157806860576;1864.6270745850884;1878.8121187881238;62944.370556294765;63166.36833631697;68439.3156068438;69981.65009174972;70781.64609176922;7376.446766492534;7405;7738.845223095506;7759.301662850257;7807.531548107132;9157.587908543997;9213.769655758526;9221.216196623362;9241.075892410705;9251.722448326562;6046.546509011841;6075.362086980804;6094.908576371358;6107.175531303217;6111.724972376253;6177.011678131477;6182.041783523561;6185.659788711664;6233.594816336924;6318.873622527615;3626.492291079251;3655.597884232732;3687.760295580779;3693.7968411737074;3719.386301260262;1258.1256027061288;1270.1553466944379;1277.3357853915911;1284.344984058137;1334.0461569977513;475.230127193948;477.99044019119424;480.742802600607;483.70493998661493;494.2758858272648;13360.532381366605;13712.3829427676;13772.931135344259;13820.37808298629;14022.228777417136;517.1467079319153;517.5445607865055;522.7647558598646;543.1011675676762;548.4241546376289;7198.568085914757;7460.925390746132;7533.698652053966;7533.962330188314;7655.157932627407;655356;659099;662713;667034;684327;85562;86710.56644716737;87152.5642371784;87584;89755;571.171800888713;572.5619900775993;573.2232824522795;574.1731906055267;575.0942265931175;12418.192817466836;12479.06407019459;12756.681082973;12800.295983720986;12828.743425131632;39629.2074158521;39677.206455871295;40089.39865901956;40732.79633601813;40808;48873;53206;54337.72831135819;54629.45370546244;54825.725871370385;7099.503034787515;7395.18652948186;7533.58565278893;7699.692012319444;7707.11368192665;12640.6839829005;12678.556250531186;13821.654458638212;13887.513937012156;13957.860421396063;12308.815367769312;12339.321337326173;12447.502099916264;12448.31534265624;12494.187877787916;11997.40012999364;12084;12157.939210303892;12172.14794964344;12198.81701774492;11979.820302695642;12387.442565084413;12440.937795310965;12645.304508252135;12748.171368860994;7019.754308599175;7353;7353.926460735538;7356.374708149867;7357.0803649543805;11683.123765717435;11924.463399146885;12088.15382923222;12130.393480326125;12153.270803751802 14:36:04 INFO - 2015-12-04 14:36:04,842 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1583.3349993002937;1584.002078690425;1774.254812978549;1838.7058070708686;1840.9690573278965;7349.118105827295;7578.128515220751;8013.8797918031205;8171.4280000399995;8192.303654189394;8043.718469853557;8202.425830191889;8220.83558328833;8239.093699693029;8285.337173026159;2380.190735150053;2412.7345991940874;2417.4802417480237;2417.528581926525;2424.9272521824373;2409.2531315292226;2414.468816860288;2453.6319552067243;2456.778889899909;2467.259822053386;2391.940201494959;2403.435192729707;2416.613341865302;2438.609822428412;2443.9389015274583;2337.135259953811;2380.143148466551;2386.85678859269;2386.9880650596724;2403.7596240375997;2401.9879900600386;2421.806255499556;2442.3894026493376;2448.461338505526;2453.84050036747;8227.71203007892;8310.587200175985;8343.624536895853;8345.165483451667;8378.455400398954;4469.486009108961;4982.327385802942;5050.646454748169;5054.267131265946;5066.164082926312;2937.911862644124;3215.3569286142865;3217.211783113129;3220.4525230710838;3318.5188147718445;1112.1436493899653;1114.7603265297919;1125.5947858770835;1145.5017067575548;1206.7827790997617;11417.086633069335;11449.599264025803;11483.196176267664;11511;11541.07671386287;4403.251447253974;4404.11917616478;4433.556644335606;4479.148961697332;4503.54964503547;9477.952610237042;9478.526073696288;9486.003969583233;9486.525673716287;9487.952560237154;4998.125328067574;5063.721495317719;5068.341115654941;5069.9746501267255;5079.796808127633;4546.29532422475;4593.977030114828;4609.654275929319;4653.302004699254;4660.533946605312;3702.185519185775;3715.498407714978;3724.1806802503406;3735.6637902588895;3761.454589084622;1101.0860985382114;1126.099120703434;1132.592266783957;1132.7791080739341;1140.1676775953601;1365.9112157709717;1387.2300873015574;1406.3179358011357;1406.3319923036477;1414.882243028017;7509.324160825552;7762.2237776223055;7798.25916537928;7811.101723301779;7828.334591559667;491.6877782607998;503.7531609511313;525.1413938210976;528.0495108804214;530.6842428754885;5864.677442740605;5893.823185304448;5902.4097590240635;5936.1095835625;5938.8812223755285;9875.506224688881;10027.649032283834;10032.548535315927;10040.14658754014;10063.69808905734;9716.708498745049;9820.263480239011;9943.757030371204;9960.501974901226;9981.101700846813;7714.961425192838;7759.456838021397;7801.726939557088;7806.297433231037;7810.101838288556;7484.962575187089;7541.622918854145;7547.320741133324;7598.088229412506;7598.544087354555;8928.776780580538;8996.775080623036;9068.183863452057;9136.771580710536;9143.03998080192;8953.955230223808;9084.273258139465;9201.263898888206;9231;9275.350725449154;7493.587852668155;7512.323890849631;7617.5048621841615;7628.199039101037;7677.193894640982;8085.474444161111;8142.104368519576;8184.468009579358;8207.302379297587;8208.46644968075;7613.809654758676;7718.421118416029;7769.689212431439;7771.067471903408;7871.0554733432355;7643.503172293783;7643.541387516767;7706.152323244551;7722.266384693445;7746.767596972099;7172.139343278631;7195.532290401107;7211.71153153868;7309.634518274172;7309.671064802203;6700.329967003261;6750.223724271772;6754.020667003355;6765.357291057342;6792.72829086831;6760.425363843931;6849.1780986281965;6927.757528486479;6935.583864968118;6945.687444064928 14:36:04 INFO - 2015-12-04 14:36:04,842 DEBUG : BROWSER_OUTPUT: |4;prototype.html;333.4248421472959;340.23786717752233;369.09019267505596;370.7775334799121;371.8624109079639;6244.281907580629;6257.655828929407;6271.968640156799;6328.24061112666;6410.230772307318;6194.5354098442685;6204.224471941007;6216.285127210373;6256.6246025238515;6256.655883926383;4781.713097214161;4787.593054590364;4789.6168306535565;4789.880252993686;4792.185328494147;4793.041391721652;4797.136515427222;4801.615870730333;4806.687565308262;4810.037992401516;4694.178518759203;4824.17988941879;4825.034993001396;4838.177509823321;4841.8547443576745;4800.0879832832;4802.975985120087;4803.375561177042;4803.423589169322;4830.637702172351;4175.728577642474;4189.916201675949;4192.161567686475;4195.119025004753;4199.748015119103;6055.394460553954;6060.030395136801;6064.484518815906;6066.63600183986;6084.60450070744;5456.672599644034;5586.217929489874;5586.966411213898;5591.4688104629995;5593.888122237573;6609.471242300604;6650.301718319603;6661.600303981777;6671.099401580822;6683.899741503881;4613.63090952723;4630.930536041962;4633.305004249356;4633.305004249356;4637;6731.798046058626;6792.93207067928;6846.8972965405555;6853.451723862079;6886.586804791728;4695.2252878275385;4697.084068606658;4698.3187437821325;4699.201135806921;4702.506236845082;4756.025014871943;4756.191447453941;4756.571908528249;4758.619310455155;4763.2140696784645;5501.944980550144;5507.449255074461;5508.283923089973;5520.944790552124;5521.171824226318;6552.410283074546;6583.9012414813815;6646.900296495556;6664.433523150587;6679.933200668028;1717.2272477385227;1730.0571188702188;1752.255291501107;1758.2791055667115;1766.6201766620238;1172.7654469106042;1174.7767924094394;1177.4230626992712;1186.2645160000855;1197.7245233596323;6328.367163283727;6335.303116657164;6336.809895703136;6342.841428964312;6355.1420558224045;6681;6714.060031595581;6722.495812814059;6723.495737819585;6757.966210169016;6390.552661313756;6417.679116044179;6421.422072013448;6451.9354306539835;6454.6449945252525;3797.1266608680157;3831.7126215533945;3833.1183827719224;3841.154945911895;3842.711796615265;7049.68276427562;7058.470614703815;7061.611611361322;7065.293470652997;7065.929340706527;6965.582065076112;7063.5761854287875;7092.574445533284;7094.326039026284;7118.679659415338;7037.894431583531;7038.3665470107935;7057.294270572902;7064.540804847668;7068.081149450539;6888.931110688829;6896.137982752156;6901;6906.689198985957;6909.654517274217;6676.499262555425;6722.226943901514;6746.4265537429865;6765.357291057342;6803.251642319242;6955.513114081966;7007.054047703698;7029;7048.823779405556;7050.083489146378;4756.405449318835;4781.043791241696;4781.713097214179;4786.760661966818;4796.496367881322;6810.761623343159;6901.827454313682;6911.3779759821855;6926.722931082701;6940.7917762467205;6688.6990085445295;6716.798496045127;6722.1261236040955;6729.360710732472;6732.596044237362;6614.437772789367;6669.46644268467;6694.866102678016;6711.765088221889;6714;6491.967540162269;6573.868522629617;6589.901151482636;6590.340965903563;6592.736290548324;6729.293424190585;6733.326667333227;6742.056112144402;6752.628605426748;6776.695048722918;6567.376099270562;6571.342865713582;6593.109930159559;6598.505112116706;6617.8014659560295 14:36:04 INFO - 2015-12-04 14:36:04,843 DEBUG : BROWSER_OUTPUT: |5;yui.html;953.8712273843031;957.2820384711466;966.9274804389672;967.8741763570735;977.540555938709;14919.776203356945;15243;15251.466198683049;15252.923735381308;15254.923725381384;14481.63795905103;14619.561413157622;14629.195394253311;14636.560903172895;14652.780208296885;757.0310003195905;917.7889085510336;925.2459245714755;927.8654595083709;933.2440723014346;918.9356745027851;927;929.7861491856877;929.8744669469603;930.7300882743996;944.3483996042743;945.5886689290146;951.6574033347989;953.7138858342504;959.366817900186;949.6154057606681;949.8622699708573;951.4814426137772;954.937929034614;958.4872093430051;707.2043950555625;707.487071872888;708.3235510087906;708.5783958544657;709.9361057504849;14841.70316593673;14932.776008359884;14935;14976.400943962228;14994.70010599782;13678.794818077737;13895.374708138057;14031.719365612631;14041.5085472008;14050;11269.66191014271;11716.121290903131;11725.120615953838;11778.882211177865;11895.94052029743;3550.3254381667402;3574.070741607175;3576.660217279354;3629.256002519477;3695.5380577427823;41859.372109418386;42435.999999999694;45421.318680219825;46753.76623116863;46944;7994.280514753584;8010.198980101944;8018.398620103516;8071;8122.878156827653;12633.494660213672;12820;12837.422315995802;12860.356982150855;12897.806532902014;7443.739469118663;7478.551286922693;7559.092908850973;7573.394128469709;7668.5782281975025;4818.518148185153;4897.2654101885;4963.875903102451;5040.067587496325;5091.9236211456855;3010.1120169550036;3013.517837146046;3032.0449058546487;3057.633084029886;3063.065764941714;537.8467136866053;539.1777539252671;543.7118327286545;544.705858836224;545.6671430427436;525.4010428111956;690.6650274616807;728.6538894025401;736.0651971995643;751.8383547537305;8560.529170895661;9166.541672916328;9221.677241296522;9282.90717092834;9354.90645093554;532.2515536462702;610.036142894226;620.3362402229661;702.5082442290417;757.9658915348823;4430.401895744098;4530.682852200381;4597.218472859555;4643.953560464352;4702.811887524529;69792.6510367455;72048;72280;72333.63833180905;72436.63781681164;60062.099068514006;60782;61110.38889611047;61348;61976;50965.745171273906;52269;56182.43817561854;56424;56681.7165914176;9162.908370916472;9255.305852061258;9607.231421486404;9810.509474526389;9856.62636821603;41738;41813.58186418097;42317;42863.78568107139;42895.57104428916;49184.508154917996;49239.26141107958;51202.74398627983;51655.225171623206;55056.724716376164;8791.560421978747;8819.559022049;9061.637534498546;9514.38156519824;9874.802503949737;12179.939100304442;12370.62888113358;12573.811392828931;12669.429875655802;12973.675658108623;12128.696782580506;12225.327606981702;12250.693732656755;12286.75426491483;12765.36173191318;11402.543898243977;11448.771024579295;11488.310701357945;11589.304641721523;11828.23116497425;12183.181014517804;12188;12411.193272437262;12455.439505222106;12473.93763031179;10630.627928022483;11064.723381915517;11170.441477926233;11344.886551134714;11465.484053217458;9759.9024009759;10105.747356316151;10332.225083118647;10341.327813692387;10526.894731052898 14:36:04 INFO - 2015-12-04 14:36:04,843 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:36:04 INFO - 2015-12-04 14:36:04,843 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:36:04 INFO - 2015-12-04 14:36:04,843 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,284 14:36:04 INFO - 2015-12-04 14:36:04,844 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:36:04 INFO - 2015-12-04 14:36:04,844 DEBUG : BROWSER_OUTPUT: __startTimestamp1449268564834__endTimestamp 14:36:04 INFO - 2015-12-04 14:36:04,844 DEBUG : BROWSER_OUTPUT: 14:36:04 INFO - 2015-12-04 14:36:04,844 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:36:04 INFO - 2015-12-04 14:36:04,844 DEBUG : BROWSER_OUTPUT: Number of tests: 6 14:36:04 INFO - 2015-12-04 14:36:04,845 DEBUG : BROWSER_OUTPUT: 14:36:04 INFO - 2015-12-04 14:36:04,845 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5804.74 Median:6065.51 stddev:658.64 (10.9%) stddev-sans-first:632.41 14:36:04 INFO - 2015-12-04 14:36:04,845 DEBUG : BROWSER_OUTPUT: Values: 3372.2 3444.7 3450.2 3473.4 3479.0 5746.5 5753.1 5782.6 5786.9 5809.1 5741.6 5805.5 5818.5 5825.6 5825.6 5256.1 5298.5 5369.5 5371.2 5394.2 5182.8 5215.7 5226.4 5243.6 5249.0 5301.4 5322.1 5408.9 5430.1 5430.2 5402.5 5418.1 5418.5 5426.1 5450.3 5111.9 5204.1 5334.1 5359.1 5417.7 5481.7 5519.9 5571.4 5608.3 5648.6 6068.1 6102.8 6108.3 6112.1 6134.6 6055.3 6118.4 6119.5 6174.2 6187.4 5832.0 5849.3 5857.7 5862.3 5883.5 6290.6 6362.6 6376.2 6390.7 6391.4 6061.8 6063.0 6158.6 6168.1 6195.2 6218.7 6259.5 6283.0 6290.5 6342.2 6222.3 6243.0 6248.4 6265.4 6271.9 5995.9 6103.8 6120.6 6252.6 6271.4 4677.0 4683.0 4685.3 4698.4 4704.3 4137.1 4267.6 4275.7 4288.6 4297.0 5871.0 5953.7 6042.5 6043.4 6096.3 6303.4 6306.9 6319.2 6336.8 6339.7 5822.3 5969.2 5986.0 6000.3 6016.4 5356.0 5415.3 5457.6 5461.8 5482.4 6430.7 6446.5 6475.3 6495.2 6495.3 6072.7 6156.2 6165.0 6380.0 6409.5 6277.7 6278.7 6379.7 6395.2 6401.6 6247.7 6289.2 6310.6 6315.4 6336.4 6119.4 6203.4 6437.2 6439.1 6446.0 6126.7 6221.4 6247.5 6263.2 6276.8 6214.4 6223.5 6228.3 6234.4 6243.1 5866.5 5972.5 5992.3 6104.9 6112.7 6144.3 6150.1 6170.6 6208.1 6232.3 6064.7 6065.5 6065.5 6072.5 6083.1 14:36:04 INFO - 2015-12-04 14:36:04,845 DEBUG : BROWSER_OUTPUT: 14:36:04 INFO - 2015-12-04 14:36:04,846 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:57511.40 Median:41193.40 stddev:109127.81 (264.9%) stddev-sans-first:109350.26 14:36:04 INFO - 2015-12-04 14:36:04,846 DEBUG : BROWSER_OUTPUT: Values: 589.8 630.9 637.6 650.2 700.9 35518.5 43472.3 43705.0 43886.6 43941.0 48623.3 48831.0 48982.3 49121.8 49395.3 9125.0 9300.7 9330.4 9345.0 9402.0 9117.0 9186.0 9231.6 9242.2 9249.9 9119.6 9149.0 9251.9 9257.2 9296.1 9050.3 9186.2 9229.9 9259.6 9264.2 9111.0 9184.2 9223.0 9274.5 9284.9 44772.0 45094.8 45248.8 45278.5 45312.8 3284.3 3361.9 3390.5 3525.6 4167.7 33540.2 33988.7 34105.7 34188.7 34253.1 3840.6 3888.2 3938.8 3951.8 3991.6 322240.0 323851.0 323913.0 326111.0 327748.0 47406.3 47410.5 66796.0 66889.3 67080.0 46450.3 46483.5 46618.8 46656.5 46733.0 14805.6 14888.1 14896.9 14911.8 14941.4 12290.4 12322.1 12349.6 12359.0 12416.5 16191.6 16286.2 16361.4 16401.3 16408.7 6100.5 6160.2 6172.2 6181.4 6185.0 947.9 1024.7 1030.5 1033.0 1133.4 35444.6 36055.1 36082.1 36381.7 36961.0 1063.5 1108.9 1166.6 1207.2 1234.3 16552.3 16674.8 16802.7 16900.4 17046.8 479703.0 522639.0 526498.0 530082.0 533864.0 60938.7 62924.7 63034.4 63055.0 63225.0 1443.4 1464.0 1472.8 1473.2 1478.2 32041.5 32287.4 32317.0 32392.8 33097.3 50207.5 50327.0 50601.0 50612.5 50845.7 364737.0 369308.0 369622.0 369791.0 370548.0 35217.3 35570.0 35607.0 35826.9 35882.0 46558.0 47206.0 55340.7 55544.7 55788.7 40251.0 40401.4 40840.0 41558.4 42026.8 41437.4 41689.4 41814.0 41991.8 42304.6 40865.6 40977.8 41031.4 41165.0 41221.8 34396.7 35376.8 36062.6 36334.6 36503.3 28005.9 28705.7 28864.7 28935.3 29367.3 14:36:04 INFO - 2015-12-04 14:36:04,846 DEBUG : BROWSER_OUTPUT: 14:36:04 INFO - 2015-12-04 14:36:04,846 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31837.99 Median:476.61 stddev:109068.07 (22884.1%) stddev-sans-first:109348.43 14:36:04 INFO - 2015-12-04 14:36:04,847 DEBUG : BROWSER_OUTPUT: Values: 371.7 373.0 373.5 376.3 378.9 12454.9 13610.0 17890.0 20988.5 21086.2 11875.2 13328.2 13416.9 13561.1 13850.3 4920.3 4944.4 4973.3 5000.9 5015.6 4867.7 4982.7 4984.3 4989.5 5134.2 4835.4 4878.4 4892.6 4896.8 4931.7 5190.9 5211.5 5213.5 5238.5 5238.7 4427.0 4453.7 4455.4 4459.9 4462.2 15314.4 15553.3 15768.8 15832.9 15964.3 2090.5 2114.1 2151.5 2167.6 2314.9 10831.9 10876.3 10952.4 11028.7 11271.4 1780.6 1819.5 1829.6 1864.6 1878.8 62944.4 63166.4 68439.3 69981.7 70781.6 7376.4 7405.0 7738.8 7759.3 7807.5 9157.6 9213.8 9221.2 9241.1 9251.7 6046.5 6075.4 6094.9 6107.2 6111.7 6177.0 6182.0 6185.7 6233.6 6318.9 3626.5 3655.6 3687.8 3693.8 3719.4 1258.1 1270.2 1277.3 1284.3 1334.0 475.2 478.0 480.7 483.7 494.3 13360.5 13712.4 13772.9 13820.4 14022.2 517.1 517.5 522.8 543.1 548.4 7198.6 7460.9 7533.7 7534.0 7655.2 655356.0 659099.0 662713.0 667034.0 684327.0 85562.0 86710.6 87152.6 87584.0 89755.0 571.2 572.6 573.2 574.2 575.1 12418.2 12479.1 12756.7 12800.3 12828.7 39629.2 39677.2 40089.4 40732.8 40808.0 48873.0 53206.0 54337.7 54629.5 54825.7 7099.5 7395.2 7533.6 7699.7 7707.1 12640.7 12678.6 13821.7 13887.5 13957.9 12308.8 12339.3 12447.5 12448.3 12494.2 11997.4 12084.0 12157.9 12172.1 12198.8 11979.8 12387.4 12440.9 12645.3 12748.2 7019.8 7353.0 7353.9 7356.4 7357.1 11683.1 11924.5 12088.2 12130.4 12153.3 14:36:04 INFO - 2015-12-04 14:36:04,847 DEBUG : BROWSER_OUTPUT: 14:36:04 INFO - 2015-12-04 14:36:04,847 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5789.57 Median:5898.12 stddev:3037.04 (51.5%) stddev-sans-first:3029.11 14:36:04 INFO - 2015-12-04 14:36:04,848 DEBUG : BROWSER_OUTPUT: Values: 1583.3 1584.0 1774.3 1838.7 1841.0 7349.1 7578.1 8013.9 8171.4 8192.3 8043.7 8202.4 8220.8 8239.1 8285.3 2380.2 2412.7 2417.5 2417.5 2424.9 2409.3 2414.5 2453.6 2456.8 2467.3 2391.9 2403.4 2416.6 2438.6 2443.9 2337.1 2380.1 2386.9 2387.0 2403.8 2402.0 2421.8 2442.4 2448.5 2453.8 8227.7 8310.6 8343.6 8345.2 8378.5 4469.5 4982.3 5050.6 5054.3 5066.2 2937.9 3215.4 3217.2 3220.5 3318.5 1112.1 1114.8 1125.6 1145.5 1206.8 11417.1 11449.6 11483.2 11511.0 11541.1 4403.3 4404.1 4433.6 4479.1 4503.5 9478.0 9478.5 9486.0 9486.5 9488.0 4998.1 5063.7 5068.3 5070.0 5079.8 4546.3 4594.0 4609.7 4653.3 4660.5 3702.2 3715.5 3724.2 3735.7 3761.5 1101.1 1126.1 1132.6 1132.8 1140.2 1365.9 1387.2 1406.3 1406.3 1414.9 7509.3 7762.2 7798.3 7811.1 7828.3 491.7 503.8 525.1 528.0 530.7 5864.7 5893.8 5902.4 5936.1 5938.9 9875.5 10027.6 10032.5 10040.1 10063.7 9716.7 9820.3 9943.8 9960.5 9981.1 7715.0 7759.5 7801.7 7806.3 7810.1 7485.0 7541.6 7547.3 7598.1 7598.5 8928.8 8996.8 9068.2 9136.8 9143.0 8954.0 9084.3 9201.3 9231.0 9275.4 7493.6 7512.3 7617.5 7628.2 7677.2 8085.5 8142.1 8184.5 8207.3 8208.5 7613.8 7718.4 7769.7 7771.1 7871.1 7643.5 7643.5 7706.2 7722.3 7746.8 7172.1 7195.5 7211.7 7309.6 7309.7 6700.3 6750.2 6754.0 6765.4 6792.7 6760.4 6849.2 6927.8 6935.6 6945.7 14:36:04 INFO - 2015-12-04 14:36:04,849 DEBUG : BROWSER_OUTPUT: 14:36:04 INFO - 2015-12-04 14:36:04,849 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5574.31 Median:6336.06 stddev:1660.30 (26.2%) stddev-sans-first:1617.69 14:36:04 INFO - 2015-12-04 14:36:04,849 DEBUG : BROWSER_OUTPUT: Values: 333.4 340.2 369.1 370.8 371.9 6244.3 6257.7 6272.0 6328.2 6410.2 6194.5 6204.2 6216.3 6256.6 6256.7 4781.7 4787.6 4789.6 4789.9 4792.2 4793.0 4797.1 4801.6 4806.7 4810.0 4694.2 4824.2 4825.0 4838.2 4841.9 4800.1 4803.0 4803.4 4803.4 4830.6 4175.7 4189.9 4192.2 4195.1 4199.7 6055.4 6060.0 6064.5 6066.6 6084.6 5456.7 5586.2 5587.0 5591.5 5593.9 6609.5 6650.3 6661.6 6671.1 6683.9 4613.6 4630.9 4633.3 4633.3 4637.0 6731.8 6792.9 6846.9 6853.5 6886.6 4695.2 4697.1 4698.3 4699.2 4702.5 4756.0 4756.2 4756.6 4758.6 4763.2 5501.9 5507.4 5508.3 5520.9 5521.2 6552.4 6583.9 6646.9 6664.4 6679.9 1717.2 1730.1 1752.3 1758.3 1766.6 1172.8 1174.8 1177.4 1186.3 1197.7 6328.4 6335.3 6336.8 6342.8 6355.1 6681.0 6714.1 6722.5 6723.5 6758.0 6390.6 6417.7 6421.4 6451.9 6454.6 3797.1 3831.7 3833.1 3841.2 3842.7 7049.7 7058.5 7061.6 7065.3 7065.9 6965.6 7063.6 7092.6 7094.3 7118.7 7037.9 7038.4 7057.3 7064.5 7068.1 6888.9 6896.1 6901.0 6906.7 6909.7 6676.5 6722.2 6746.4 6765.4 6803.3 6955.5 7007.1 7029.0 7048.8 7050.1 4756.4 4781.0 4781.7 4786.8 4796.5 6810.8 6901.8 6911.4 6926.7 6940.8 6688.7 6716.8 6722.1 6729.4 6732.6 6614.4 6669.5 6694.9 6711.8 6714.0 6492.0 6573.9 6589.9 6590.3 6592.7 6729.3 6733.3 6742.1 6752.6 6776.7 6567.4 6571.3 6593.1 6598.5 6617.8 14:36:04 INFO - 2015-12-04 14:36:04,849 DEBUG : BROWSER_OUTPUT: 14:36:04 INFO - 2015-12-04 14:36:04,849 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15161.18 Median:28028.83 stddev:18647.97 (66.5%) stddev-sans-first:18669.76 14:36:04 INFO - 2015-12-04 14:36:04,850 DEBUG : BROWSER_OUTPUT: Values: 953.9 957.3 966.9 967.9 977.5 14919.8 15243.0 15251.5 15252.9 15254.9 14481.6 14619.6 14629.2 14636.6 14652.8 757.0 917.8 925.2 927.9 933.2 918.9 927.0 929.8 929.9 930.7 944.3 945.6 951.7 953.7 959.4 949.6 949.9 951.5 954.9 958.5 707.2 707.5 708.3 708.6 709.9 14841.7 14932.8 14935.0 14976.4 14994.7 13678.8 13895.4 14031.7 14041.5 14050.0 11269.7 11716.1 11725.1 11778.9 11895.9 3550.3 3574.1 3576.7 3629.3 3695.5 41859.4 42436.0 45421.3 46753.8 46944.0 7994.3 8010.2 8018.4 8071.0 8122.9 12633.5 12820.0 12837.4 12860.4 12897.8 7443.7 7478.6 7559.1 7573.4 7668.6 4818.5 4897.3 4963.9 5040.1 5091.9 3010.1 3013.5 3032.0 3057.6 3063.1 537.8 539.2 543.7 544.7 545.7 525.4 690.7 728.7 736.1 751.8 8560.5 9166.5 9221.7 9282.9 9354.9 532.3 610.0 620.3 702.5 758.0 4430.4 4530.7 4597.2 4644.0 4702.8 69792.7 72048.0 72280.0 72333.6 72436.6 60062.1 60782.0 61110.4 61348.0 61976.0 50965.7 52269.0 56182.4 56424.0 56681.7 9162.9 9255.3 9607.2 9810.5 9856.6 41738.0 41813.6 42317.0 42863.8 42895.6 49184.5 49239.3 51202.7 51655.2 55056.7 8791.6 8819.6 9061.6 9514.4 9874.8 12179.9 12370.6 12573.8 12669.4 12973.7 12128.7 12225.3 12250.7 12286.8 12765.4 11402.5 11448.8 11488.3 11589.3 11828.2 12183.2 12188.0 12411.2 12455.4 12473.9 10630.6 11064.7 11170.4 11344.9 11465.5 9759.9 10105.7 10332.2 10341.3 10526.9 14:36:04 INFO - 2015-12-04 14:36:04,850 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:36:04 INFO - 2015-12-04 14:36:04,851 DEBUG : BROWSER_OUTPUT: 14:36:05 INFO - 2015-12-04 14:36:05,496 INFO : Browser exited with error code: 0 14:36:05 INFO - 2015-12-04 14:36:05,518 INFO : Completed test dromaeo_css (00:18:27) 14:36:05 INFO - 2015-12-04 14:36:05,518 INFO : Starting test kraken 14:36:05 INFO - 2015-12-04 14:36:05,518 DEBUG : operating with platform_type : linux_ 14:36:05 INFO - 2015-12-04 14:36:05,518 INFO : Initialising browser for kraken test... 14:36:05 INFO - 2015-12-04 14:36:05,524 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4erP_s/profile http://localhost:36746/getInfo.html 14:36:10 INFO - 2015-12-04 14:36:10,105 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:36:10 INFO - 2015-12-04 14:36:10,105 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:36:10 INFO - 2015-12-04 14:36:10,105 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:36:10 INFO - 2015-12-04 14:36:10,105 DEBUG : BROWSER_OUTPUT: __metrics 14:36:11 INFO - 2015-12-04 14:36:11,033 INFO : Browser initialized. 14:36:11 INFO - 2015-12-04 14:36:11,034 INFO : Running cycle 1/1 for kraken test... 14:36:11 INFO - 2015-12-04 14:36:11,034 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp4erP_s/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:36:22 INFO - 2015-12-04 14:36:22,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 133578752 14:36:22 INFO - 2015-12-04 14:36:22,740 DEBUG : BROWSER_OUTPUT: 14:36:25 INFO - 2015-12-04 14:36:25,216 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36746/tests/kraken/driver.html?testName=audio-beat-detection) 14:36:25 INFO - 2015-12-04 14:36:25,806 DEBUG : BROWSER_OUTPUT: RSS: Main: 134643712 14:36:25 INFO - 2015-12-04 14:36:25,806 DEBUG : BROWSER_OUTPUT: 14:36:28 INFO - 2015-12-04 14:36:28,408 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36746/tests/kraken/driver.html?testName=audio-dft) 14:36:28 INFO - 2015-12-04 14:36:28,990 DEBUG : BROWSER_OUTPUT: RSS: Main: 135684096 14:36:28 INFO - 2015-12-04 14:36:28,990 DEBUG : BROWSER_OUTPUT: 14:36:31 INFO - 2015-12-04 14:36:31,811 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36746/tests/kraken/driver.html?testName=audio-fft) 14:36:32 INFO - 2015-12-04 14:36:32,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 135655424 14:36:32 INFO - 2015-12-04 14:36:32,386 DEBUG : BROWSER_OUTPUT: 14:36:34 INFO - 2015-12-04 14:36:34,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36746/tests/kraken/driver.html?testName=audio-oscillator) 14:36:34 INFO - 2015-12-04 14:36:34,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 135417856 14:36:34 INFO - 2015-12-04 14:36:34,957 DEBUG : BROWSER_OUTPUT: 14:36:37 INFO - 2015-12-04 14:36:37,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:36:37 INFO - 2015-12-04 14:36:37,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 136314880 14:36:37 INFO - 2015-12-04 14:36:37,696 DEBUG : BROWSER_OUTPUT: 14:36:40 INFO - 2015-12-04 14:36:40,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36746/tests/kraken/driver.html?testName=imaging-darkroom) 14:36:41 INFO - 2015-12-04 14:36:41,259 DEBUG : BROWSER_OUTPUT: RSS: Main: 135655424 14:36:41 INFO - 2015-12-04 14:36:41,260 DEBUG : BROWSER_OUTPUT: 14:36:44 INFO - 2015-12-04 14:36:44,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36746/tests/kraken/driver.html?testName=imaging-desaturate) 14:36:45 INFO - 2015-12-04 14:36:45,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 135811072 14:36:45 INFO - 2015-12-04 14:36:45,198 DEBUG : BROWSER_OUTPUT: 14:36:47 INFO - 2015-12-04 14:36:47,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36746/tests/kraken/driver.html?testName=json-parse-financial) 14:36:48 INFO - 2015-12-04 14:36:48,558 DEBUG : BROWSER_OUTPUT: RSS: Main: 135491584 14:36:48 INFO - 2015-12-04 14:36:48,558 DEBUG : BROWSER_OUTPUT: 14:36:50 INFO - 2015-12-04 14:36:50,094 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:36:50 INFO - 2015-12-04 14:36:50,676 DEBUG : BROWSER_OUTPUT: RSS: Main: 134975488 14:36:50 INFO - 2015-12-04 14:36:50,676 DEBUG : BROWSER_OUTPUT: 14:36:52 INFO - 2015-12-04 14:36:52,410 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36746/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:36:53 INFO - 2015-12-04 14:36:53,019 DEBUG : BROWSER_OUTPUT: RSS: Main: 135811072 14:36:53 INFO - 2015-12-04 14:36:53,020 DEBUG : BROWSER_OUTPUT: 14:36:55 INFO - 2015-12-04 14:36:55,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:36:55 INFO - 2015-12-04 14:36:55,628 DEBUG : BROWSER_OUTPUT: RSS: Main: 135954432 14:36:55 INFO - 2015-12-04 14:36:55,628 DEBUG : BROWSER_OUTPUT: 14:36:57 INFO - 2015-12-04 14:36:57,994 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:36:58 INFO - 2015-12-04 14:36:58,584 DEBUG : BROWSER_OUTPUT: RSS: Main: 136167424 14:36:58 INFO - 2015-12-04 14:36:58,584 DEBUG : BROWSER_OUTPUT: 14:37:01 INFO - 2015-12-04 14:37:01,051 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:37:01 INFO - 2015-12-04 14:37:01,637 DEBUG : BROWSER_OUTPUT: RSS: Main: 135335936 14:37:01 INFO - 2015-12-04 14:37:01,638 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36746/tests/kraken/driver.html?testName=ai-astar) 14:37:03 INFO - 2015-12-04 14:37:03,533 DEBUG : BROWSER_OUTPUT: RSS: Main: 136515584 14:37:03 INFO - 2015-12-04 14:37:03,533 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,534 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;105;109;110;109;121;113;110;112;110 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;123;146;161;129;156;156;124;156;128 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;163;161;165;162;162;163;167;161 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;72;161;73;71;73;71;169;70 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;138;89;90;90;142;89;89;134 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;111;110;110;110;111;110 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;148;149;148;147;147;147;147 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;97;96;97;96;96;97;96;96;96 14:37:03 INFO - 2015-12-04 14:37:03,535 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;57;59;58;58;61;62;63;64;56;58 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;61;62;61;61;62;64;61;62;64;62 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;82;80;83;82;80;88;83;88;81 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;117;122;119;115;120;115;114;113;112;112 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;141;127;139;153;139;139;137;155;137;131 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;67;73;64;70;65;62;63;64;62 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: __start_cc_report 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,692 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: __end_cc_report 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: __startTimestamp1449268623533__endTimestamp 14:37:03 INFO - 2015-12-04 14:37:03,536 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,540 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:37:03 INFO - 2015-12-04 14:37:03,540 DEBUG : BROWSER_OUTPUT: Number of tests: 14 14:37:03 INFO - 2015-12-04 14:37:03,540 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,540 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.90 Median:110.00 stddev:4.12 (3.7%) stddev-sans-first:4.36 14:37:03 INFO - 2015-12-04 14:37:03,540 DEBUG : BROWSER_OUTPUT: Values: 110.0 105.0 109.0 110.0 109.0 121.0 113.0 110.0 112.0 110.0 14:37:03 INFO - 2015-12-04 14:37:03,541 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,541 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.10 Median:154.00 stddev:15.29 (9.9%) stddev-sans-first:15.87 14:37:03 INFO - 2015-12-04 14:37:03,541 DEBUG : BROWSER_OUTPUT: Values: 152.0 123.0 146.0 161.0 129.0 156.0 156.0 124.0 156.0 128.0 14:37:03 INFO - 2015-12-04 14:37:03,542 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,542 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.70 Median:162.50 stddev:1.95 (1.2%) stddev-sans-first:2.05 14:37:03 INFO - 2015-12-04 14:37:03,542 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 163.0 161.0 165.0 162.0 162.0 163.0 167.0 161.0 14:37:03 INFO - 2015-12-04 14:37:03,542 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,542 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:90.30 Median:71.50 stddev:39.43 (55.1%) stddev-sans-first:41.26 14:37:03 INFO - 2015-12-04 14:37:03,543 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 72.0 161.0 73.0 71.0 73.0 71.0 169.0 70.0 14:37:03 INFO - 2015-12-04 14:37:03,543 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,543 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.10 Median:89.50 stddev:23.47 (26.2%) stddev-sans-first:24.34 14:37:03 INFO - 2015-12-04 14:37:03,543 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 138.0 89.0 90.0 90.0 142.0 89.0 89.0 134.0 14:37:03 INFO - 2015-12-04 14:37:03,543 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,544 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 14:37:03 INFO - 2015-12-04 14:37:03,544 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 111.0 110.0 110.0 110.0 111.0 110.0 14:37:03 INFO - 2015-12-04 14:37:03,544 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,544 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 14:37:03 INFO - 2015-12-04 14:37:03,545 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 148.0 149.0 148.0 147.0 147.0 147.0 147.0 14:37:03 INFO - 2015-12-04 14:37:03,545 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,545 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 14:37:03 INFO - 2015-12-04 14:37:03,545 DEBUG : BROWSER_OUTPUT: Values: 97.0 97.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 14:37:03 INFO - 2015-12-04 14:37:03,545 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,545 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.60 Median:60.00 stddev:2.72 (4.5%) stddev-sans-first:2.71 14:37:03 INFO - 2015-12-04 14:37:03,545 DEBUG : BROWSER_OUTPUT: Values: 57.0 59.0 58.0 58.0 61.0 62.0 63.0 64.0 56.0 58.0 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:62.00 Median:62.00 stddev:1.15 (1.9%) stddev-sans-first:1.17 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: Values: 61.0 62.0 61.0 61.0 62.0 64.0 61.0 62.0 64.0 62.0 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:82.50 stddev:3.02 (3.7%) stddev-sans-first:3.04 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 80.0 83.0 82.0 80.0 88.0 83.0 88.0 81.0 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.90 Median:116.00 stddev:3.48 (3.0%) stddev-sans-first:3.67 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: Values: 117.0 122.0 119.0 115.0 120.0 115.0 114.0 113.0 112.0 112.0 14:37:03 INFO - 2015-12-04 14:37:03,546 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,547 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:139.00 stddev:8.60 (6.2%) stddev-sans-first:9.11 14:37:03 INFO - 2015-12-04 14:37:03,547 DEBUG : BROWSER_OUTPUT: Values: 141.0 127.0 139.0 153.0 139.0 139.0 137.0 155.0 137.0 131.0 14:37:03 INFO - 2015-12-04 14:37:03,547 DEBUG : BROWSER_OUTPUT: 14:37:03 INFO - 2015-12-04 14:37:03,547 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.60 Median:65.50 stddev:3.57 (5.4%) stddev-sans-first:3.78 14:37:03 INFO - 2015-12-04 14:37:03,547 DEBUG : BROWSER_OUTPUT: Values: 66.0 67.0 73.0 64.0 70.0 65.0 62.0 63.0 64.0 62.0 14:37:03 INFO - 2015-12-04 14:37:03,547 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:37:03 INFO - 2015-12-04 14:37:03,547 DEBUG : BROWSER_OUTPUT: 14:37:04 INFO - 2015-12-04 14:37:04,305 INFO : Browser exited with error code: 0 14:37:04 INFO - 2015-12-04 14:37:04,364 INFO : Completed test kraken (00:00:58) 14:37:04 INFO - 2015-12-04 14:37:04,364 INFO : Starting test v8_7 14:37:04 INFO - 2015-12-04 14:37:04,364 DEBUG : operating with platform_type : linux_ 14:37:04 INFO - 2015-12-04 14:37:04,365 INFO : Initialising browser for v8_7 test... 14:37:04 INFO - 2015-12-04 14:37:04,371 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdhIcjX/profile http://localhost:36746/getInfo.html 14:37:08 INFO - 2015-12-04 14:37:08,942 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 14:37:08 INFO - 2015-12-04 14:37:08,943 DEBUG : BROWSER_OUTPUT: colorDepth:24 14:37:08 INFO - 2015-12-04 14:37:08,943 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 14:37:08 INFO - 2015-12-04 14:37:08,943 DEBUG : BROWSER_OUTPUT: __metrics 14:37:09 INFO - 2015-12-04 14:37:09,829 INFO : Browser initialized. 14:37:09 INFO - 2015-12-04 14:37:09,830 INFO : Running cycle 1/1 for v8_7 test... 14:37:09 INFO - 2015-12-04 14:37:09,830 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpdhIcjX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 14:37:21 INFO - 2015-12-04 14:37:21,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 134086656 14:37:21 INFO - 2015-12-04 14:37:21,493 DEBUG : BROWSER_OUTPUT: 14:37:42 INFO - 2015-12-04 14:37:42,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:36746/tests/v8_7/run.html (next: http://localhost:36746/tests/v8_7/run.html) 14:37:43 INFO - 2015-12-04 14:37:43,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 132055040 14:37:43 INFO - 2015-12-04 14:37:43,100 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,101 DEBUG : BROWSER_OUTPUT: __start_tp_report 14:37:43 INFO - 2015-12-04 14:37:43,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 14:37:43 INFO - 2015-12-04 14:37:43,101 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 14:37:43 INFO - 2015-12-04 14:37:43,102 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 14:37:43 INFO - 2015-12-04 14:37:43,102 DEBUG : BROWSER_OUTPUT: |0;Richards;164.52780519907864 14:37:43 INFO - 2015-12-04 14:37:43,102 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;164.79894528675015 14:37:43 INFO - 2015-12-04 14:37:43,102 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.214848143982 14:37:43 INFO - 2015-12-04 14:37:43,102 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 14:37:43 INFO - 2015-12-04 14:37:43,102 DEBUG : BROWSER_OUTPUT: |4;RayTrace;906.6183136899365 14:37:43 INFO - 2015-12-04 14:37:43,102 DEBUG : BROWSER_OUTPUT: |5;Earley;549.7526113249038 14:37:43 INFO - 2015-12-04 14:37:43,102 DEBUG : BROWSER_OUTPUT: |6;Boyer;10453.60824742268 14:37:43 INFO - 2015-12-04 14:37:43,103 DEBUG : BROWSER_OUTPUT: |7;RegExp;23833.333333333332 14:37:43 INFO - 2015-12-04 14:37:43,103 DEBUG : BROWSER_OUTPUT: |8;Splay;515.9958720330237 14:37:43 INFO - 2015-12-04 14:37:43,103 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 14:37:43 INFO - 2015-12-04 14:37:43,103 DEBUG : BROWSER_OUTPUT: __end_tp_report 14:37:43 INFO - 2015-12-04 14:37:43,103 DEBUG : BROWSER_OUTPUT: __startTimestamp1449268663100__endTimestamp 14:37:43 INFO - 2015-12-04 14:37:43,104 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,104 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 14:37:43 INFO - 2015-12-04 14:37:43,104 DEBUG : BROWSER_OUTPUT: Number of tests: 10 14:37:43 INFO - 2015-12-04 14:37:43,104 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,104 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.53 Median:164.53 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,104 DEBUG : BROWSER_OUTPUT: Values: 164.5 14:37:43 INFO - 2015-12-04 14:37:43,105 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,105 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:164.80 Median:164.80 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,105 DEBUG : BROWSER_OUTPUT: Values: 164.8 14:37:43 INFO - 2015-12-04 14:37:43,105 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,105 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.21 Median:281.21 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,106 DEBUG : BROWSER_OUTPUT: Values: 281.2 14:37:43 INFO - 2015-12-04 14:37:43,106 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,106 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,106 DEBUG : BROWSER_OUTPUT: Values: 5020.0 14:37:43 INFO - 2015-12-04 14:37:43,106 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,108 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:906.62 Median:906.62 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,108 DEBUG : BROWSER_OUTPUT: Values: 906.6 14:37:43 INFO - 2015-12-04 14:37:43,108 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,108 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:549.75 Median:549.75 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,108 DEBUG : BROWSER_OUTPUT: Values: 549.8 14:37:43 INFO - 2015-12-04 14:37:43,108 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,108 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10453.61 Median:10453.61 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: Values: 10453.6 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:23833.33 Median:23833.33 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: Values: 23833.3 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:516.00 Median:516.00 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: Values: 516.0 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 14:37:43 INFO - 2015-12-04 14:37:43,109 DEBUG : BROWSER_OUTPUT: Values: 4822.1 14:37:43 INFO - 2015-12-04 14:37:43,110 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 14:37:43 INFO - 2015-12-04 14:37:43,110 DEBUG : BROWSER_OUTPUT: 14:37:43 INFO - 2015-12-04 14:37:43,921 INFO : Browser exited with error code: 0 14:37:43 INFO - 2015-12-04 14:37:43,939 INFO : Completed test v8_7 (00:00:39) 14:37:44 INFO - 2015-12-04 14:37:44,155 INFO : Completed test suite (00:20:06) 14:37:44 INFO - 2015-12-04 14:37:44,155 DEBUG : Working with test: dromaeo_css 14:37:44 INFO - 2015-12-04 14:37:44,156 DEBUG : Generating results file: dromaeo_css 14:37:44 INFO - 2015-12-04 14:37:44,157 DEBUG : Working with test: kraken 14:37:44 INFO - 2015-12-04 14:37:44,157 DEBUG : Generating results file: kraken 14:37:44 INFO - 2015-12-04 14:37:44,157 INFO : javascript benchmark 14:37:44 INFO - 2015-12-04 14:37:44,157 DEBUG : Working with test: v8_7 14:37:44 INFO - 2015-12-04 14:37:44,157 DEBUG : Generating results file: v8_7 14:37:44 INFO - 2015-12-04 14:37:44,158 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:44 INFO - 2015-12-04 14:37:44,217 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 14:37:44 INFO - 2015-12-04 14:37:44,217 DEBUG : process_Request line: dromaeo_css 7203.78 graph.html#tests=[[72,52,43]] 14:37:44 INFO - 2015-12-04 14:37:44,217 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:44 INFO - 2015-12-04 14:37:44,259 DEBUG : process_Request line: kraken 1490.50 graph.html#tests=[[232,52,43]] 14:37:44 INFO - 2015-12-04 14:37:44,259 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 14:37:44 INFO - 2015-12-04 14:37:44,290 DEBUG : process_Request line: v8_7 23554.47 graph.html#tests=[[230,52,43]] 14:37:44 INFO - 2015-12-04 14:37:44,292 INFO : javascript benchmark 14:37:44 INFO - 2015-12-04 14:37:44,295 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3372.15696075981, 3444.707199888009, 3450.2236996675733, 3473.409520381535, 3479.0432631026474, 5746.482816546515, 5753.108268218432, 5782.566307526931, 5786.942130578693, 5809.128630705396, 5741.62679425837, 5805.506531944779, 5818.476337129658, 5825.563082768798, 5825.592208545403, 5256.132738098209, 5298.47015298469, 5369.463053694639, 5371.167469042305, 5394.1908713692865, 5182.766775495112, 5215.660982036175, 5226.360687852629, 5243.554297884684, 5249.0, 5301.390340110879, 5322.0952438085615, 5408.864778380553, 5430.104032834578, 5430.212619170218, 5402.459754024605, 5418.106012507931, 5418.485243901842, 5426.077566813651, 5450.31871016123, 5111.872203194913, 5204.115300398941, 5334.0665383557725, 5359.1425371940695, 5417.674939503642, 5481.725913704338, 5519.917201241985, 5571.387147413781, 5608.298962629671, 5648.63283886546, 6068.120122582245, 6102.7864024759365, 6108.3280839107665, 6112.052631842072, 6134.570580059398, 6055.27336719592, 6118.449339559416, 6119.533019689815, 6174.197354343906, 6187.381261873777, 5832.008558545015, 5849.268841394825, 5857.736401861884, 5862.267216597926, 5883.470487656089, 6290.55966082379, 6362.618242905348, 6376.234851817719, 6390.7218556288, 6391.392817682313, 6061.787837425669, 6063.0, 6158.630482171084, 6168.1056246843955, 6195.1636529068, 6218.689065546704, 6259.499240060784, 6283.0, 6290.496760259169, 6342.23893132827, 6222.28443728977, 6243.0, 6248.4064013918605, 6265.373462653698, 6271.905921411182, 5995.940040599626, 6103.755849766048, 6120.599512025043, 6252.624842509464, 6271.372862713783, 4676.976615116902, 4682.953170468251, 4685.250359942393, 4698.389209402756, 4704.294355846582, 4137.089840235143, 4267.594578515036, 4275.743455392686, 4288.614024737789, 4297.0, 5871.031279838779, 5953.732082056318, 6042.456178943916, 6043.425874541911, 6096.268447786294, 6303.369663033752, 6306.905396419057, 6319.24169099711, 6336.809895703136, 6339.651319177397, 5822.301323841166, 5969.164316995624, 5986.0, 6000.33996260411, 6016.42843929826, 5356.0, 5415.323084614423, 5457.61796674229, 5461.781528738886, 5482.396936337, 6430.678466076677, 6446.548741588138, 6475.287718350977, 6495.220573531112, 6495.253045899782, 6072.666003369681, 6156.199694039746, 6165.0444181152, 6380.0, 6409.519286053472, 6277.654728989949, 6278.748850045947, 6379.7129129190225, 6395.232572091193, 6401.647909364843, 6247.718852651732, 6289.213848268966, 6310.5898116622275, 6315.368463153648, 6336.398042185985, 6119.44924956756, 6203.410675985774, 6437.227532696106, 6439.098526206241, 6446.0, 6126.663033533198, 6221.4089661482085, 6247.5001999839, 6263.185785847811, 6276.811695649138, 6214.40963108504, 6223.471004964447, 6228.28374736893, 6234.376562343729, 6243.063540468966, 5866.50134738535, 5972.492338151305, 5992.340842507408, 6104.9389506106145, 6112.72492737819, 6144.324124346229, 6150.138980542638, 6170.598911070766, 6208.0998255253635, 6232.252129744278, 6064.666443345658, 6065.514758819372, 6065.54508411862, 6072.514198864169, 6083.087536869505], "unit": "ms", "name": "dojo.html", "value": 5760.716728339839}, {"lowerIsBetter": false, "replicates": [589.8142085243148, 630.9116723658688, 637.5664548107287, 650.1807722269939, 700.9193942696588, 35518.46722299165, 43472.347914781305, 43705.0, 43886.56113438865, 43941.0, 48623.27065094026, 48831.0, 48982.26526602104, 49121.75439122808, 49395.259071113964, 9125.04187060359, 9300.697902293685, 9330.440173589606, 9345.0, 9401.952990235039, 9116.954415227914, 9186.0, 9231.6307347706, 9242.214411775007, 9249.861252081224, 9119.635214591408, 9148.954255228748, 9251.861222081674, 9257.16685498305, 9296.070392960717, 9050.32122590805, 9186.219171370441, 9229.907700922971, 9259.58331875064, 9264.212541933945, 9111.0, 9184.17342439177, 9222.95388523053, 9274.536273186313, 9284.860727089099, 44772.0, 45094.77452612716, 45248.77375613134, 45278.54721452776, 45312.77343613261, 3284.3267130238246, 3361.9495707564406, 3390.4744764561533, 3525.6121826599056, 4167.729097608646, 33540.1614959628, 33988.66011339879, 34105.6589434105, 34188.658113418795, 34253.143671408165, 3840.5967373425947, 3888.2223555289056, 3938.8424463021443, 3951.7826519541413, 3991.6435507961824, 322240.0, 323851.0, 323913.0, 326111.0, 327748.0, 47406.28890566644, 47410.5258947413, 66796.0, 66889.3311066883, 67080.0, 46450.303245451345, 46483.535164648594, 46618.76690616593, 46656.5334346659, 46733.0, 14805.629859253604, 14888.106713597002, 14896.851031489763, 14911.776323355158, 14941.40234390634, 12290.446929888176, 12322.137450378388, 12349.567765128177, 12359.0, 12416.503339866485, 16191.595210119842, 16286.185690715654, 16361.427350042692, 16401.261943212583, 16408.67182656364, 6100.542459315569, 6160.229971253593, 6172.166757487771, 6181.443670069715, 6184.969075154685, 947.9004704505927, 1024.6516184497307, 1030.5465595138114, 1033.0, 1133.3653154233655, 35444.64555354465, 36055.066936876596, 36082.097947550996, 36381.72663956749, 36961.0, 1063.5373612478597, 1108.922375433712, 1166.6150170443734, 1207.1911819081236, 1234.3457967277357, 16552.33790648385, 16674.83325166733, 16802.747958780627, 16900.40848570319, 17046.82953170477, 479703.0, 522639.0, 526498.0, 530082.0, 533864.0, 60938.69530652319, 62924.68537657282, 63034.36965630377, 63055.0, 63225.0, 1443.3793468808303, 1464.0, 1472.8379878213389, 1473.2412807404196, 1478.2313197137644, 32041.51937720983, 32287.35425291434, 32317.0, 32392.83803580967, 33097.338053239284, 50207.49792502028, 50327.0, 50601.0, 50612.49387506225, 50845.74577127091, 364737.0, 369308.0, 369622.0, 369791.0, 370548.0, 35217.295654087284, 35570.0, 35607.0, 35826.92519224427, 35882.0, 46558.0, 47206.0, 55340.72329638326, 55544.72227638836, 55788.72105639446, 40251.0, 40401.39397909093, 40840.0, 41558.37662435006, 42026.78986605047, 41437.378439324035, 41689.37465938074, 41813.989239047325, 41991.7900410496, 42304.57695423006, 40865.59134408618, 40977.79511102426, 41031.38452923149, 41165.0, 41221.79389103036, 34396.65603343934, 35376.823115884254, 36062.63937360698, 36334.636653633126, 36503.26993460063, 28005.859970700018, 28705.712942870305, 28864.711352886203, 28935.276618084717, 29367.265818354714], "unit": "ms", "name": "ext.html", "value": 20139.51837675539}, {"lowerIsBetter": false, "replicates": [371.6822117089888, 372.9794861282629, 373.5125661012378, 376.2906920454945, 378.8503541101266, 12454.875451245485, 13609.979251556124, 17889.999999999985, 20988.475288117806, 21086.156553737834, 11875.16873818833, 13328.200307981504, 13416.865831341684, 13561.11852729572, 13850.307484625779, 4920.335754673118, 4944.381952255968, 4973.278874563186, 5000.949990500103, 5015.623828212881, 4867.68360056597, 4982.651214414975, 4984.277279794428, 4989.525995030466, 5134.229865520165, 4835.371401717772, 4878.4145902491755, 4892.5596696297325, 4896.804127834882, 4931.679440836352, 5190.92213616796, 5211.452797456251, 5213.504717051874, 5238.47615238475, 5238.685678859261, 4426.9778651106535, 4453.688241823073, 4455.353973673799, 4459.910801783946, 4462.174497717932, 15314.387424503118, 15553.30010149546, 15768.81733869953, 15832.92083539575, 15964.281607327699, 2090.4773806548365, 2114.112072929358, 2151.5266641339035, 2167.5556510915226, 2314.8958296876513, 10831.891681083167, 10876.347419154798, 10952.397618130999, 11028.669139925814, 11271.436428178558, 1780.6171673090219, 1819.5451137215696, 1829.6157806860576, 1864.6270745850884, 1878.8121187881238, 62944.370556294765, 63166.36833631697, 68439.3156068438, 69981.65009174972, 70781.64609176922, 7376.446766492534, 7405.0, 7738.845223095506, 7759.301662850257, 7807.531548107132, 9157.587908543997, 9213.769655758526, 9221.216196623362, 9241.075892410705, 9251.722448326562, 6046.546509011841, 6075.362086980804, 6094.908576371358, 6107.175531303217, 6111.724972376253, 6177.011678131477, 6182.041783523561, 6185.659788711664, 6233.594816336924, 6318.873622527615, 3626.492291079251, 3655.597884232732, 3687.760295580779, 3693.7968411737074, 3719.386301260262, 1258.1256027061288, 1270.1553466944379, 1277.3357853915911, 1284.344984058137, 1334.0461569977513, 475.230127193948, 477.99044019119424, 480.742802600607, 483.70493998661493, 494.2758858272648, 13360.532381366605, 13712.3829427676, 13772.931135344259, 13820.37808298629, 14022.228777417136, 517.1467079319153, 517.5445607865055, 522.7647558598646, 543.1011675676762, 548.4241546376289, 7198.568085914757, 7460.925390746132, 7533.698652053966, 7533.962330188314, 7655.157932627407, 655356.0, 659099.0, 662713.0, 667034.0, 684327.0, 85562.0, 86710.56644716737, 87152.5642371784, 87584.0, 89755.0, 571.171800888713, 572.5619900775993, 573.2232824522795, 574.1731906055267, 575.0942265931175, 12418.192817466836, 12479.06407019459, 12756.681082973, 12800.295983720986, 12828.743425131632, 39629.2074158521, 39677.206455871295, 40089.39865901956, 40732.79633601813, 40808.0, 48873.0, 53206.0, 54337.72831135819, 54629.45370546244, 54825.725871370385, 7099.503034787515, 7395.18652948186, 7533.58565278893, 7699.692012319444, 7707.11368192665, 12640.6839829005, 12678.556250531186, 13821.654458638212, 13887.513937012156, 13957.860421396063, 12308.815367769312, 12339.321337326173, 12447.502099916264, 12448.31534265624, 12494.187877787916, 11997.40012999364, 12084.0, 12157.939210303892, 12172.14794964344, 12198.81701774492, 11979.820302695642, 12387.442565084413, 12440.937795310965, 12645.304508252135, 12748.171368860994, 7019.754308599175, 7353.0, 7353.926460735538, 7356.374708149867, 7357.0803649543805, 11683.123765717435, 11924.463399146885, 12088.15382923222, 12130.393480326125, 12153.270803751802], "unit": "ms", "name": "jquery.html", "value": 7612.175012131106}, {"lowerIsBetter": false, "replicates": [1583.3349993002937, 1584.002078690425, 1774.254812978549, 1838.7058070708686, 1840.9690573278965, 7349.118105827295, 7578.128515220751, 8013.8797918031205, 8171.4280000399995, 8192.303654189394, 8043.718469853557, 8202.425830191889, 8220.83558328833, 8239.093699693029, 8285.337173026159, 2380.190735150053, 2412.7345991940874, 2417.4802417480237, 2417.528581926525, 2424.9272521824373, 2409.2531315292226, 2414.468816860288, 2453.6319552067243, 2456.778889899909, 2467.259822053386, 2391.940201494959, 2403.435192729707, 2416.613341865302, 2438.609822428412, 2443.9389015274583, 2337.135259953811, 2380.143148466551, 2386.85678859269, 2386.9880650596724, 2403.7596240375997, 2401.9879900600386, 2421.806255499556, 2442.3894026493376, 2448.461338505526, 2453.84050036747, 8227.71203007892, 8310.587200175985, 8343.624536895853, 8345.165483451667, 8378.455400398954, 4469.486009108961, 4982.327385802942, 5050.646454748169, 5054.267131265946, 5066.164082926312, 2937.911862644124, 3215.3569286142865, 3217.211783113129, 3220.4525230710838, 3318.5188147718445, 1112.1436493899653, 1114.7603265297919, 1125.5947858770835, 1145.5017067575548, 1206.7827790997617, 11417.086633069335, 11449.599264025803, 11483.196176267664, 11511.0, 11541.07671386287, 4403.251447253974, 4404.11917616478, 4433.556644335606, 4479.148961697332, 4503.54964503547, 9477.952610237042, 9478.526073696288, 9486.003969583233, 9486.525673716287, 9487.952560237154, 4998.125328067574, 5063.721495317719, 5068.341115654941, 5069.9746501267255, 5079.796808127633, 4546.29532422475, 4593.977030114828, 4609.654275929319, 4653.302004699254, 4660.533946605312, 3702.185519185775, 3715.498407714978, 3724.1806802503406, 3735.6637902588895, 3761.454589084622, 1101.0860985382114, 1126.099120703434, 1132.592266783957, 1132.7791080739341, 1140.1676775953601, 1365.9112157709717, 1387.2300873015574, 1406.3179358011357, 1406.3319923036477, 1414.882243028017, 7509.324160825552, 7762.2237776223055, 7798.25916537928, 7811.101723301779, 7828.334591559667, 491.6877782607998, 503.7531609511313, 525.1413938210976, 528.0495108804214, 530.6842428754885, 5864.677442740605, 5893.823185304448, 5902.4097590240635, 5936.1095835625, 5938.8812223755285, 9875.506224688881, 10027.649032283834, 10032.548535315927, 10040.14658754014, 10063.69808905734, 9716.708498745049, 9820.263480239011, 9943.757030371204, 9960.501974901226, 9981.101700846813, 7714.961425192838, 7759.456838021397, 7801.726939557088, 7806.297433231037, 7810.101838288556, 7484.962575187089, 7541.622918854145, 7547.320741133324, 7598.088229412506, 7598.544087354555, 8928.776780580538, 8996.775080623036, 9068.183863452057, 9136.771580710536, 9143.03998080192, 8953.955230223808, 9084.273258139465, 9201.263898888206, 9231.0, 9275.350725449154, 7493.587852668155, 7512.323890849631, 7617.5048621841615, 7628.199039101037, 7677.193894640982, 8085.474444161111, 8142.104368519576, 8184.468009579358, 8207.302379297587, 8208.46644968075, 7613.809654758676, 7718.421118416029, 7769.689212431439, 7771.067471903408, 7871.0554733432355, 7643.503172293783, 7643.541387516767, 7706.152323244551, 7722.266384693445, 7746.767596972099, 7172.139343278631, 7195.532290401107, 7211.71153153868, 7309.634518274172, 7309.671064802203, 6700.329967003261, 6750.223724271772, 6754.020667003355, 6765.357291057342, 6792.72829086831, 6760.425363843931, 6849.1780986281965, 6927.757528486479, 6935.583864968118, 6945.687444064928], "unit": "ms", "name": "mootools.html", "value": 4673.1384907551865}, {"lowerIsBetter": false, "replicates": [333.4248421472959, 340.23786717752233, 369.09019267505596, 370.7775334799121, 371.8624109079639, 6244.281907580629, 6257.655828929407, 6271.968640156799, 6328.24061112666, 6410.230772307318, 6194.5354098442685, 6204.224471941007, 6216.285127210373, 6256.6246025238515, 6256.655883926383, 4781.713097214161, 4787.593054590364, 4789.6168306535565, 4789.880252993686, 4792.185328494147, 4793.041391721652, 4797.136515427222, 4801.615870730333, 4806.687565308262, 4810.037992401516, 4694.178518759203, 4824.17988941879, 4825.034993001396, 4838.177509823321, 4841.8547443576745, 4800.0879832832, 4802.975985120087, 4803.375561177042, 4803.423589169322, 4830.637702172351, 4175.728577642474, 4189.916201675949, 4192.161567686475, 4195.119025004753, 4199.748015119103, 6055.394460553954, 6060.030395136801, 6064.484518815906, 6066.63600183986, 6084.60450070744, 5456.672599644034, 5586.217929489874, 5586.966411213898, 5591.4688104629995, 5593.888122237573, 6609.471242300604, 6650.301718319603, 6661.600303981777, 6671.099401580822, 6683.899741503881, 4613.63090952723, 4630.930536041962, 4633.305004249356, 4633.305004249356, 4637.0, 6731.798046058626, 6792.93207067928, 6846.8972965405555, 6853.451723862079, 6886.586804791728, 4695.2252878275385, 4697.084068606658, 4698.3187437821325, 4699.201135806921, 4702.506236845082, 4756.025014871943, 4756.191447453941, 4756.571908528249, 4758.619310455155, 4763.2140696784645, 5501.944980550144, 5507.449255074461, 5508.283923089973, 5520.944790552124, 5521.171824226318, 6552.410283074546, 6583.9012414813815, 6646.900296495556, 6664.433523150587, 6679.933200668028, 1717.2272477385227, 1730.0571188702188, 1752.255291501107, 1758.2791055667115, 1766.6201766620238, 1172.7654469106042, 1174.7767924094394, 1177.4230626992712, 1186.2645160000855, 1197.7245233596323, 6328.367163283727, 6335.303116657164, 6336.809895703136, 6342.841428964312, 6355.1420558224045, 6681.0, 6714.060031595581, 6722.495812814059, 6723.495737819585, 6757.966210169016, 6390.552661313756, 6417.679116044179, 6421.422072013448, 6451.9354306539835, 6454.6449945252525, 3797.1266608680157, 3831.7126215533945, 3833.1183827719224, 3841.154945911895, 3842.711796615265, 7049.68276427562, 7058.470614703815, 7061.611611361322, 7065.293470652997, 7065.929340706527, 6965.582065076112, 7063.5761854287875, 7092.574445533284, 7094.326039026284, 7118.679659415338, 7037.894431583531, 7038.3665470107935, 7057.294270572902, 7064.540804847668, 7068.081149450539, 6888.931110688829, 6896.137982752156, 6901.0, 6906.689198985957, 6909.654517274217, 6676.499262555425, 6722.226943901514, 6746.4265537429865, 6765.357291057342, 6803.251642319242, 6955.513114081966, 7007.054047703698, 7029.0, 7048.823779405556, 7050.083489146378, 4756.405449318835, 4781.043791241696, 4781.713097214179, 4786.760661966818, 4796.496367881322, 6810.761623343159, 6901.827454313682, 6911.3779759821855, 6926.722931082701, 6940.7917762467205, 6688.6990085445295, 6716.798496045127, 6722.1261236040955, 6729.360710732472, 6732.596044237362, 6614.437772789367, 6669.46644268467, 6694.866102678016, 6711.765088221889, 6714.0, 6491.967540162269, 6573.868522629617, 6589.901151482636, 6590.340965903563, 6592.736290548324, 6729.293424190585, 6733.326667333227, 6742.056112144402, 6752.628605426748, 6776.695048722918, 6567.376099270562, 6571.342865713582, 6593.109930159559, 6598.505112116706, 6617.8014659560295], "unit": "ms", "name": "prototype.html", "value": 5040.427902959116}, {"lowerIsBetter": false, "replicates": [953.8712273843031, 957.2820384711466, 966.9274804389672, 967.8741763570735, 977.540555938709, 14919.776203356945, 15243.0, 15251.466198683049, 15252.923735381308, 15254.923725381384, 14481.63795905103, 14619.561413157622, 14629.195394253311, 14636.560903172895, 14652.780208296885, 757.0310003195905, 917.7889085510336, 925.2459245714755, 927.8654595083709, 933.2440723014346, 918.9356745027851, 927.0, 929.7861491856877, 929.8744669469603, 930.7300882743996, 944.3483996042743, 945.5886689290146, 951.6574033347989, 953.7138858342504, 959.366817900186, 949.6154057606681, 949.8622699708573, 951.4814426137772, 954.937929034614, 958.4872093430051, 707.2043950555625, 707.487071872888, 708.3235510087906, 708.5783958544657, 709.9361057504849, 14841.70316593673, 14932.776008359884, 14935.0, 14976.400943962228, 14994.70010599782, 13678.794818077737, 13895.374708138057, 14031.719365612631, 14041.5085472008, 14050.0, 11269.66191014271, 11716.121290903131, 11725.120615953838, 11778.882211177865, 11895.94052029743, 3550.3254381667402, 3574.070741607175, 3576.660217279354, 3629.256002519477, 3695.5380577427823, 41859.372109418386, 42435.999999999694, 45421.318680219825, 46753.76623116863, 46944.0, 7994.280514753584, 8010.198980101944, 8018.398620103516, 8071.0, 8122.878156827653, 12633.494660213672, 12820.0, 12837.422315995802, 12860.356982150855, 12897.806532902014, 7443.739469118663, 7478.551286922693, 7559.092908850973, 7573.394128469709, 7668.5782281975025, 4818.518148185153, 4897.2654101885, 4963.875903102451, 5040.067587496325, 5091.9236211456855, 3010.1120169550036, 3013.517837146046, 3032.0449058546487, 3057.633084029886, 3063.065764941714, 537.8467136866053, 539.1777539252671, 543.7118327286545, 544.705858836224, 545.6671430427436, 525.4010428111956, 690.6650274616807, 728.6538894025401, 736.0651971995643, 751.8383547537305, 8560.529170895661, 9166.541672916328, 9221.677241296522, 9282.90717092834, 9354.90645093554, 532.2515536462702, 610.036142894226, 620.3362402229661, 702.5082442290417, 757.9658915348823, 4430.401895744098, 4530.682852200381, 4597.218472859555, 4643.953560464352, 4702.811887524529, 69792.6510367455, 72048.0, 72280.0, 72333.63833180905, 72436.63781681164, 60062.099068514006, 60782.0, 61110.38889611047, 61348.0, 61976.0, 50965.745171273906, 52269.0, 56182.43817561854, 56424.0, 56681.7165914176, 9162.908370916472, 9255.305852061258, 9607.231421486404, 9810.509474526389, 9856.62636821603, 41738.0, 41813.58186418097, 42317.0, 42863.78568107139, 42895.57104428916, 49184.508154917996, 49239.26141107958, 51202.74398627983, 51655.225171623206, 55056.724716376164, 8791.560421978747, 8819.559022049, 9061.637534498546, 9514.38156519824, 9874.802503949737, 12179.939100304442, 12370.62888113358, 12573.811392828931, 12669.429875655802, 12973.675658108623, 12128.696782580506, 12225.327606981702, 12250.693732656755, 12286.75426491483, 12765.36173191318, 11402.543898243977, 11448.771024579295, 11488.310701357945, 11589.304641721523, 11828.23116497425, 12183.181014517804, 12188.0, 12411.193272437262, 12455.439505222106, 12473.93763031179, 10630.627928022483, 11064.723381915517, 11170.441477926233, 11344.886551134714, 11465.484053217458, 9759.9024009759, 10105.747356316151, 10332.225083118647, 10341.327813692387, 10526.894731052898], "unit": "ms", "name": "yui.html", "value": 6717.596421525814}], "name": "dromaeo_css", "value": 7203.773660403192}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 105.0, 109.0, 110.0, 109.0, 121.0, 113.0, 110.0, 112.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.9}, {"lowerIsBetter": true, "replicates": [152.0, 123.0, 146.0, 161.0, 129.0, 156.0, 156.0, 124.0, 156.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.1}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 163.0, 161.0, 165.0, 162.0, 162.0, 163.0, 167.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 162.7}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 72.0, 161.0, 73.0, 71.0, 73.0, 71.0, 169.0, 70.0], "unit": "ms", "name": "audio-fft", "value": 90.3}, {"lowerIsBetter": true, "replicates": [90.0, 90.0, 138.0, 89.0, 90.0, 90.0, 142.0, 89.0, 89.0, 134.0], "unit": "ms", "name": "audio-oscillator", "value": 104.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 148.0, 149.0, 148.0, 147.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.3}, {"lowerIsBetter": true, "replicates": [97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [57.0, 59.0, 58.0, 58.0, 61.0, 62.0, 63.0, 64.0, 56.0, 58.0], "unit": "ms", "name": "json-parse-financial", "value": 59.6}, {"lowerIsBetter": true, "replicates": [61.0, 62.0, 61.0, 61.0, 62.0, 64.0, 61.0, 62.0, 64.0, 62.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 62.0}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 80.0, 83.0, 82.0, 80.0, 88.0, 83.0, 88.0, 81.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.7}, {"lowerIsBetter": true, "replicates": [117.0, 122.0, 119.0, 115.0, 120.0, 115.0, 114.0, 113.0, 112.0, 112.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.9}, {"lowerIsBetter": true, "replicates": [141.0, 127.0, 139.0, 153.0, 139.0, 139.0, 137.0, 155.0, 137.0, 131.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 73.0, 64.0, 70.0, 65.0, 62.0, 63.0, 64.0, 62.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.6}], "name": "kraken", "value": 1490.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.52780519907864], "unit": "score", "name": "Richards", "value": 214.56555600000002}, {"lowerIsBetter": false, "replicates": [164.79894528675015], "unit": "score", "name": "DeltaBlue", "value": 401.20402399999995}, {"lowerIsBetter": false, "replicates": [281.214848143982], "unit": "score", "name": "Encrypt", "value": 946.5396360000002}, {"lowerIsBetter": false, "replicates": [5020.0], "unit": "score", "name": "Decrypt", "value": 53.0241035856574}, {"lowerIsBetter": false, "replicates": [906.6183136899365], "unit": "score", "name": "RayTrace", "value": 816.2078669999997}, {"lowerIsBetter": false, "replicates": [549.7526113249038], "unit": "score", "name": "Earley", "value": 1212.296197}, {"lowerIsBetter": false, "replicates": [10453.60824742268], "unit": "score", "name": "Boyer", "value": 63.7543500986193}, {"lowerIsBetter": false, "replicates": [23833.333333333332], "unit": "score", "name": "RegExp", "value": 38.22314685314689}, {"lowerIsBetter": false, "replicates": [515.9958720330237], "unit": "score", "name": "Splay", "value": 157.92955799999993}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 23554.46545046442}]} 14:37:44 INFO - RETURN: dromaeo_css: 7203.78 14:37:44 INFO - RETURN: kraken: 1490.50 14:37:44 INFO - RETURN: v8_7: 23554.47 14:37:44 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23554.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1490.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7203.78"}}} 14:37:44 INFO - Return code: 0 14:37:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 14:37:44 INFO - # TBPL SUCCESS # 14:37:44 INFO - Running post-action listener: _resource_record_post_action 14:37:44 INFO - Running post-run listener: _resource_record_post_run 14:37:45 INFO - Total resource usage - Wall time: 1222s; CPU: 13.0%; Read bytes: 4096; Write bytes: 512475136; Read time: 220; Write time: 726920 14:37:45 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 246550528; Read time: 0; Write time: 524892 14:37:45 INFO - run-tests - Wall time: 1208s; CPU: 13.0%; Read bytes: 4096; Write bytes: 261066752; Read time: 220; Write time: 201684 14:37:45 INFO - Running post-run listener: _upload_blobber_files 14:37:45 INFO - Blob upload gear active. 14:37:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 14:37:45 INFO - Copying logs to upload dir... 14:37:45 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1255.976558 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2015-12-04 14:37:44.811125) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 14:37:44.814460) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009997 build_url: 'https://queue.taskcluster.net/v1/task/TyvwetlPQS2_-OxQAUA-7A/artifacts/public/build/firefox-44.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-04 14:37:44.865013) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:37:44.865338) ========= 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=e25b24362c3bb3dea6e300e4000001c1-1449267407.948406-557090373 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-04 14:37:44.915563) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 14:37:44.915889) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-04 14:37:44.916247) ========= ========= Total master_lag: 0.22 =========