builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1448743893.37 results: success (0) buildid: 20151128113004 builduid: 23c5942ec4bc4843930b84d97633de12 revision: 959df62d450d8d8d51252ba9c292b668835ac3e7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.368501) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.368959) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.369254) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.009180 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.437233) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.437558) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.530718) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.530991) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004625 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.588562) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.588850) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.589201) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.589515) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-28 12:51:34-- 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% 23.3M=0s 2015-11-28 12:51:35 (23.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.196228 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.801619) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.801945) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018884 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.852144) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:33.852470) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 959df62d450d8d8d51252ba9c292b668835ac3e7 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 959df62d450d8d8d51252ba9c292b668835ac3e7 --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=6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-28 12:51:35,206 truncating revision to first 12 chars 2015-11-28 12:51:35,206 Setting DEBUG logging. 2015-11-28 12:51:35,206 attempt 1/10 2015-11-28 12:51:35,206 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/959df62d450d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-28 12:51:35,529 unpacking tar archive at: fx-team-959df62d450d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.615125 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:34.480296) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:34.480593) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:34.494887) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:34.495135) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-28 12:51:34.495513) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-11-28 12:51:34.495794) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:51:35 INFO - MultiFileLogger online at 20151128 12:51:35 in /builds/slave/test-pgo 12:51:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:51:35 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:51:35 INFO - {'append_to_log': False, 12:51:35 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:51:35 INFO - 'blob_upload_branch': 'Fx-Team', 12:51:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:51:35 INFO - 'branch': 'Fx-Team', 12:51:35 INFO - 'buildbot_json_path': 'buildprops.json', 12:51:35 INFO - 'config_files': ('talos/linux_config.py',), 12:51:35 INFO - 'default_actions': ('clobber', 12:51:35 INFO - 'read-buildbot-config', 12:51:35 INFO - 'download-and-extract', 12:51:35 INFO - 'populate-webroot', 12:51:35 INFO - 'create-virtualenv', 12:51:35 INFO - 'install', 12:51:35 INFO - 'run-tests'), 12:51:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:51:35 INFO - 'download_minidump_stackwalk': True, 12:51:35 INFO - 'download_symbols': 'ondemand', 12:51:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:51:35 INFO - 'tooltool.py': '/tools/tooltool.py', 12:51:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:51:35 INFO - '/tools/misc-python/virtualenv.py')}, 12:51:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:51:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:51:35 INFO - 'installer_path': 'installer.exe', 12:51:35 INFO - 'log_level': 'info', 12:51:35 INFO - 'log_name': 'talos', 12:51:35 INFO - 'log_to_console': True, 12:51:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:51:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:51:35 INFO - 'opt_config_files': (), 12:51:35 INFO - 'pip_index': False, 12:51:35 INFO - 'sps_profile': False, 12:51:35 INFO - 'sps_profile_interval': 0, 12:51:35 INFO - 'suite': 'dromaeojs-e10s', 12:51:35 INFO - 'system_bits': '64', 12:51:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:51:35 INFO - 'title': 'talos-linux64-ix-007', 12:51:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:51:35 INFO - 'use_talos_json': True, 12:51:35 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:51:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:51:35 INFO - 'work_dir': 'build'} 12:51:35 INFO - ##### 12:51:35 INFO - ##### Running clobber step. 12:51:35 INFO - ##### 12:51:35 INFO - Running pre-action listener: _resource_record_pre_action 12:51:35 INFO - Running main action method: clobber 12:51:35 INFO - rmtree: /builds/slave/test-pgo/build 12:51:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:51:36 INFO - Running post-action listener: _resource_record_post_action 12:51:36 INFO - ##### 12:51:36 INFO - ##### Running read-buildbot-config step. 12:51:36 INFO - ##### 12:51:36 INFO - Running pre-action listener: _resource_record_pre_action 12:51:36 INFO - Running main action method: read_buildbot_config 12:51:36 INFO - Using buildbot properties: 12:51:36 INFO - { 12:51:36 INFO - "properties": { 12:51:36 INFO - "buildnumber": 115, 12:51:36 INFO - "product": "firefox", 12:51:36 INFO - "script_repo_revision": "production", 12:51:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 12:51:36 INFO - "repository": "", 12:51:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 12:51:36 INFO - "buildid": "20151128113004", 12:51:36 INFO - "slavename": "talos-linux64-ix-007", 12:51:36 INFO - "pgo_build": "True", 12:51:36 INFO - "basedir": "/builds/slave/test-pgo", 12:51:36 INFO - "project": "", 12:51:36 INFO - "platform": "ubuntu64_hw", 12:51:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 12:51:36 INFO - "slavebuilddir": "test", 12:51:36 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 12:51:36 INFO - "branch": "fx-team", 12:51:36 INFO - "repo_path": "integration/fx-team", 12:51:36 INFO - "stage_platform": "linux64-pgo", 12:51:36 INFO - "builduid": "23c5942ec4bc4843930b84d97633de12", 12:51:36 INFO - "revision": "959df62d450d8d8d51252ba9c292b668835ac3e7" 12:51:36 INFO - }, 12:51:36 INFO - "sourcestamp": { 12:51:36 INFO - "repository": "", 12:51:36 INFO - "hasPatch": false, 12:51:36 INFO - "project": "", 12:51:36 INFO - "branch": "fx-team-linux64-pgo-talos", 12:51:36 INFO - "changes": [ 12:51:36 INFO - { 12:51:36 INFO - "category": null, 12:51:36 INFO - "files": [ 12:51:36 INFO - { 12:51:36 INFO - "url": null, 12:51:36 INFO - "name": "https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:51:36 INFO - } 12:51:36 INFO - ], 12:51:36 INFO - "repository": "", 12:51:36 INFO - "rev": "959df62d450d8d8d51252ba9c292b668835ac3e7", 12:51:36 INFO - "who": "sendchange", 12:51:36 INFO - "when": 1448743835, 12:51:36 INFO - "number": 6717616, 12:51:36 INFO - "comments": "", 12:51:36 INFO - "project": "", 12:51:36 INFO - "at": "Sat 28 Nov 2015 12:50:35", 12:51:36 INFO - "branch": "fx-team-linux64-pgo-talos", 12:51:36 INFO - "revlink": "", 12:51:36 INFO - "properties": [ 12:51:36 INFO - [ 12:51:36 INFO - "buildid", 12:51:36 INFO - "20151128113004", 12:51:36 INFO - "Change" 12:51:36 INFO - ], 12:51:36 INFO - [ 12:51:36 INFO - "builduid", 12:51:36 INFO - "23c5942ec4bc4843930b84d97633de12", 12:51:36 INFO - "Change" 12:51:36 INFO - ], 12:51:36 INFO - [ 12:51:36 INFO - "pgo_build", 12:51:36 INFO - "True", 12:51:36 INFO - "Change" 12:51:36 INFO - ] 12:51:36 INFO - ], 12:51:36 INFO - "revision": "959df62d450d8d8d51252ba9c292b668835ac3e7" 12:51:36 INFO - } 12:51:36 INFO - ], 12:51:36 INFO - "revision": "959df62d450d8d8d51252ba9c292b668835ac3e7" 12:51:36 INFO - } 12:51:36 INFO - } 12:51:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:51:36 INFO - Running post-action listener: _resource_record_post_action 12:51:36 INFO - ##### 12:51:36 INFO - ##### Running download-and-extract step. 12:51:36 INFO - ##### 12:51:36 INFO - Running pre-action listener: _resource_record_pre_action 12:51:36 INFO - Running main action method: download_and_extract 12:51:36 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:51: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')]} 12:51:36 INFO - https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:51:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/test_packages.json 12:51:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/test_packages.json 12:51:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:51:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:51:41 INFO - Downloaded 1302 bytes. 12:51:41 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:51:41 INFO - Using the following test package requirements: 12:51:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:51:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:41 INFO - u'jsshell-linux-x86_64.zip'], 12:51:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:51:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:51:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:51:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:51:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:51:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:51:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:51:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:51:41 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')]} 12:51:41 INFO - https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:51:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:51:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:51:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:51:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:51:44 INFO - Downloaded 22762442 bytes. 12:51:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:51:44 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:51:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:51:45 INFO - Return code: 0 12:51:45 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:45 INFO - https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:51:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:51:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:51:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:51:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:51:50 INFO - Downloaded 22762442 bytes. 12:51:50 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:51:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:51:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:51:51 INFO - Return code: 0 12:51: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')]} 12:51:51 INFO - https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:51:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:51:52 INFO - Downloaded 11131728 bytes. 12:51:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 12:51:52 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:51:52 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:51:53 INFO - Return code: 0 12:51: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')]} 12:51:53 INFO - https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:51:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:51:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:51:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:51:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:51:54 INFO - Downloaded 58418658 bytes. 12:51:54 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:51:54 INFO - mkdir: /builds/slave/test-pgo/properties 12:51:54 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:51:54 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:51:54 INFO - Contents: 12:51:54 INFO - build_url:https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:51:54 INFO - Running post-action listener: _resource_record_post_action 12:51:54 INFO - Running post-action listener: set_extra_try_arguments 12:51:54 INFO - ##### 12:51:54 INFO - ##### Running populate-webroot step. 12:51:54 INFO - ##### 12:51:54 INFO - Running pre-action listener: _resource_record_pre_action 12:51:54 INFO - Running main action method: populate_webroot 12:51:54 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:51:54 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:51:54 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:51:54 INFO - '../fennec_ids.txt'], 12:51:54 INFO - 'tests': ['tcheck2']}, 12:51:54 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:51:54 INFO - '--tppagecycles', 12:51:54 INFO - '7'], 12:51:54 INFO - 'tests': ['tsvgm']}}, 12:51:54 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:51:54 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:51:54 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:51:54 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:51:54 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:51:54 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:51:54 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:54 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:54 INFO - 'talos_options': ['--e10s'], 12:51:54 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:51:54 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:54 INFO - 'tests': ['damp', 'tps']}, 12:51:54 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:54 INFO - 'talos_options': ['--e10s'], 12:51:54 INFO - 'tests': ['damp', 'tps']}, 12:51:54 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:51:54 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:51:54 INFO - 'other': {'tests': ['a11yr', 12:51:54 INFO - 'ts_paint', 12:51:54 INFO - 'tpaint', 12:51:54 INFO - 'sessionrestore', 12:51:54 INFO - 'sessionrestore_no_auto_restore']}, 12:51:54 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:51:54 INFO - 'tests': ['a11yr', 12:51:54 INFO - 'ts_paint', 12:51:54 INFO - 'tpaint', 12:51:54 INFO - 'sessionrestore', 12:51:54 INFO - 'sessionrestore_no_auto_restore']}, 12:51:54 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:51:54 INFO - 'tests': ['a11yr', 12:51:54 INFO - 'ts_paint', 12:51:54 INFO - 'tpaint', 12:51:54 INFO - 'sessionrestore', 12:51:54 INFO - 'sessionrestore_no_auto_restore']}, 12:51:54 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:51:54 INFO - 'tests': ['a11yr', 12:51:54 INFO - 'ts_paint', 12:51:54 INFO - 'tpaint', 12:51:54 INFO - 'sessionrestore', 12:51:54 INFO - 'sessionrestore_no_auto_restore']}, 12:51:54 INFO - 'other_l64': {'tests': ['a11yr', 12:51:54 INFO - 'ts_paint', 12:51:54 INFO - 'tpaint', 12:51:54 INFO - 'sessionrestore', 12:51:54 INFO - 'sessionrestore_no_auto_restore']}, 12:51:54 INFO - 'other_nol64': {'tests': ['a11yr', 12:51:54 INFO - 'ts_paint', 12:51:54 INFO - 'tpaint', 12:51:54 INFO - 'sessionrestore', 12:51:54 INFO - 'sessionrestore_no_auto_restore']}, 12:51:54 INFO - 'svgr': {'tests': ['tsvgx', 12:51:54 INFO - 'tsvgr_opacity', 12:51:54 INFO - 'tart', 12:51:54 INFO - 'tscrollx', 12:51:54 INFO - 'cart']}, 12:51:54 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:51:54 INFO - 'tests': ['tsvgx', 12:51:54 INFO - 'tsvgr_opacity', 12:51:54 INFO - 'tart', 12:51:54 INFO - 'tscrollx', 12:51:54 INFO - 'cart']}, 12:51:54 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:54 INFO - 'tests': ['tp5o']}, 12:51:54 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:54 INFO - 'talos_options': ['--e10s'], 12:51:54 INFO - 'tests': ['tp5o']}, 12:51:54 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:54 INFO - 'talos_options': ['--xperf_path', 12:51:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:54 INFO - 'tests': ['tp5n']}, 12:51:54 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:51:54 INFO - 'talos_options': ['--e10s', 12:51:54 INFO - '--xperf_path', 12:51:54 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:51:54 INFO - 'tests': ['tp5n']}}, 12:51:54 INFO - 'talos.zip': {'path': '', 12:51:54 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:51:54 INFO - Running post-action listener: _resource_record_post_action 12:51:54 INFO - ##### 12:51:54 INFO - ##### Running create-virtualenv step. 12:51:54 INFO - ##### 12:51:54 INFO - Running pre-action listener: _resource_record_pre_action 12:51:54 INFO - Running main action method: create_virtualenv 12:51:54 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:51:54 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 12:51:54 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:51:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:51:54 INFO - Using real prefix '/usr' 12:51:54 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:51:55 INFO - Installing distribute.............................................................................................................................................................................................done. 12:51:57 INFO - Installing pip.................done. 12:51:57 INFO - Return code: 0 12:51:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:51: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')]} 12:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1bbae6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, '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': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', '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 12:51:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 12:51:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:51:57 INFO - Using env: {'DISPLAY': ':0', 12:51:57 INFO - 'HOME': '/home/cltbld', 12:51:57 INFO - 'LANG': 'en_US.UTF-8', 12:51:57 INFO - 'LANGUAGE': 'en_US:en', 12:51:57 INFO - 'LOGNAME': 'cltbld', 12:51:57 INFO - 'MAIL': '/var/mail/cltbld', 12:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:57 INFO - 'MOZ_NO_REMOTE': '1', 12:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:57 INFO - 'NO_EM_RESTART': '1', 12:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:57 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:57 INFO - 'SHELL': '/bin/bash', 12:51:57 INFO - 'SHLVL': '1', 12:51:57 INFO - 'TERM': 'linux', 12:51:57 INFO - 'TMOUT': '86400', 12:51:57 INFO - 'USER': 'cltbld', 12:51:57 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:57 INFO - '_': '/tools/buildbot/bin/python'} 12:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:57 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 12:51:57 INFO - Cleaning up... 12:51:57 INFO - Return code: 0 12:51:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:51: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')]} 12:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51: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')]} 12:51:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:57 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1bbae6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, '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': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', '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 12:51:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 12:51:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:51:57 INFO - Using env: {'DISPLAY': ':0', 12:51:57 INFO - 'HOME': '/home/cltbld', 12:51:57 INFO - 'LANG': 'en_US.UTF-8', 12:51:57 INFO - 'LANGUAGE': 'en_US:en', 12:51:57 INFO - 'LOGNAME': 'cltbld', 12:51:57 INFO - 'MAIL': '/var/mail/cltbld', 12:51:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:57 INFO - 'MOZ_NO_REMOTE': '1', 12:51:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:57 INFO - 'NO_EM_RESTART': '1', 12:51:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:57 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:57 INFO - 'SHELL': '/bin/bash', 12:51:57 INFO - 'SHLVL': '1', 12:51:57 INFO - 'TERM': 'linux', 12:51:57 INFO - 'TMOUT': '86400', 12:51:57 INFO - 'USER': 'cltbld', 12:51:57 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:51:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:57 INFO - '_': '/tools/buildbot/bin/python'} 12:51:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:51:57 INFO - Downloading/unpacking psutil>=0.7.1 12:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:51:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:51:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:51:59 INFO - Creating supposed download cache at /builds/slave/test-pgo/build/venv/cache 12:51:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:51:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:51:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:59 INFO - Installing collected packages: psutil 12:51:59 INFO - Running setup.py install for psutil 12:51:59 INFO - building 'psutil._psutil_linux' extension 12:51:59 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 12:51:59 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 12:51:59 INFO - building 'psutil._psutil_posix' extension 12:51:59 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 12:51:59 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 12:51:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:51:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:51:59 INFO - Successfully installed psutil 12:51:59 INFO - Cleaning up... 12:51:59 INFO - Return code: 0 12:51:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:51:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:51:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:51:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:51:59 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1bbae6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, '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': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', '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 12:51:59 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 12:51:59 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --download-cache /builds/slave/test-pgo/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:51:59 INFO - Using env: {'DISPLAY': ':0', 12:51:59 INFO - 'HOME': '/home/cltbld', 12:51:59 INFO - 'LANG': 'en_US.UTF-8', 12:51:59 INFO - 'LANGUAGE': 'en_US:en', 12:51:59 INFO - 'LOGNAME': 'cltbld', 12:51:59 INFO - 'MAIL': '/var/mail/cltbld', 12:51:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:51:59 INFO - 'MOZ_NO_REMOTE': '1', 12:51:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:51:59 INFO - 'NO_EM_RESTART': '1', 12:51:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:51:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:51:59 INFO - 'PWD': '/builds/slave/test-pgo', 12:51:59 INFO - 'SHELL': '/bin/bash', 12:51:59 INFO - 'SHLVL': '1', 12:51:59 INFO - 'TERM': 'linux', 12:51:59 INFO - 'TMOUT': '86400', 12:51:59 INFO - 'USER': 'cltbld', 12:51:59 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:51:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:51:59 INFO - '_': '/tools/buildbot/bin/python'} 12:52:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:52:00 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 12:52:00 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 12:52:00 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 12:52:00 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 12:52:00 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 12:52:00 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 12:52:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:52:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:52:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:52:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:52:01 INFO - Installing collected packages: mozsystemmonitor 12:52:01 INFO - Running setup.py install for mozsystemmonitor 12:52:01 INFO - Successfully installed mozsystemmonitor 12:52:01 INFO - Cleaning up... 12:52:01 INFO - Return code: 0 12:52:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:52: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')]} 12:52:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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', '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 0x7f1bbae6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, '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': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', '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 12:52: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 12:52: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 blobuploader==1.2.4 12:52:01 INFO - Using env: {'DISPLAY': ':0', 12:52:01 INFO - 'HOME': '/home/cltbld', 12:52:01 INFO - 'LANG': 'en_US.UTF-8', 12:52:01 INFO - 'LANGUAGE': 'en_US:en', 12:52:01 INFO - 'LOGNAME': 'cltbld', 12:52:01 INFO - 'MAIL': '/var/mail/cltbld', 12:52:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:01 INFO - 'MOZ_NO_REMOTE': '1', 12:52:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:01 INFO - 'NO_EM_RESTART': '1', 12:52:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:01 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:01 INFO - 'SHELL': '/bin/bash', 12:52:01 INFO - 'SHLVL': '1', 12:52:01 INFO - 'TERM': 'linux', 12:52:01 INFO - 'TMOUT': '86400', 12:52:01 INFO - 'USER': 'cltbld', 12:52:01 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:52:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:01 INFO - '_': '/tools/buildbot/bin/python'} 12:52:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:02 INFO - Downloading/unpacking blobuploader==1.2.4 12:52:02 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 12:52:02 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 12:52:02 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 12:52:02 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 12:52:02 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 12:52:02 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 12:52:03 INFO - Downloading blobuploader-1.2.4.tar.gz 12:52:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:52:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:52:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:52:03 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 12:52:03 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 12:52:03 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 12:52:03 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 12:52:03 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 12:52:03 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 12:52:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:52:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:52:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52:04 INFO - Downloading docopt-0.6.1.tar.gz 12:52:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:52:04 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:52:04 INFO - Installing collected packages: blobuploader, requests, docopt 12:52:04 INFO - Running setup.py install for blobuploader 12:52:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:52:04 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:52:04 INFO - Running setup.py install for requests 12:52:04 INFO - Running setup.py install for docopt 12:52:05 INFO - Successfully installed blobuploader requests docopt 12:52:05 INFO - Cleaning up... 12:52:05 INFO - Return code: 0 12:52:05 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:05 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 0x7f1bbae6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, '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': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', '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 12:52:05 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 12:52:05 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 12:52:05 INFO - Using env: {'DISPLAY': ':0', 12:52:05 INFO - 'HOME': '/home/cltbld', 12:52:05 INFO - 'LANG': 'en_US.UTF-8', 12:52:05 INFO - 'LANGUAGE': 'en_US:en', 12:52:05 INFO - 'LOGNAME': 'cltbld', 12:52:05 INFO - 'MAIL': '/var/mail/cltbld', 12:52:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:05 INFO - 'MOZ_NO_REMOTE': '1', 12:52:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:05 INFO - 'NO_EM_RESTART': '1', 12:52:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:05 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:05 INFO - 'SHELL': '/bin/bash', 12:52:05 INFO - 'SHLVL': '1', 12:52:05 INFO - 'TERM': 'linux', 12:52:05 INFO - 'TMOUT': '86400', 12:52:05 INFO - 'USER': 'cltbld', 12:52:05 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:52:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:05 INFO - '_': '/tools/buildbot/bin/python'} 12:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:52:05 INFO - Running setup.py (path:/tmp/pip-d3SFAX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:52:05 INFO - Running setup.py (path:/tmp/pip-z3bn0t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:52:05 INFO - Running setup.py (path:/tmp/pip-9gaodJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:52:05 INFO - Running setup.py (path:/tmp/pip-yDPcbj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:52:05 INFO - Running setup.py (path:/tmp/pip-y9dXSu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:52:05 INFO - Running setup.py (path:/tmp/pip-D3AZ8m-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:52:05 INFO - Running setup.py (path:/tmp/pip-bNtsWQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:52:05 INFO - Running setup.py (path:/tmp/pip-THpN_3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:52:05 INFO - Running setup.py (path:/tmp/pip-eSwuLm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:52:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:52:05 INFO - Running setup.py (path:/tmp/pip-EX3xf4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:52:06 INFO - Running setup.py (path:/tmp/pip-l671x7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:52:06 INFO - Running setup.py (path:/tmp/pip-VsTP_U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:52:06 INFO - Running setup.py (path:/tmp/pip-HebjqS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:52:06 INFO - Running setup.py (path:/tmp/pip-oJ4ybP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:52:06 INFO - Running setup.py (path:/tmp/pip-qJHHgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:52:06 INFO - Running setup.py (path:/tmp/pip-5RR4wY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:52:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:52:06 INFO - Running setup.py (path:/tmp/pip-z82Lex-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:52:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:52:06 INFO - Running setup.py install for manifestparser 12:52:06 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:52:06 INFO - Running setup.py install for mozcrash 12:52:06 INFO - Running setup.py install for mozdebug 12:52:06 INFO - Running setup.py install for mozdevice 12:52:06 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:52:06 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:52:06 INFO - Running setup.py install for mozfile 12:52:07 INFO - Running setup.py install for mozhttpd 12:52:07 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Running setup.py install for mozinfo 12:52:07 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Running setup.py install for mozInstall 12:52:07 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Running setup.py install for mozleak 12:52:07 INFO - Running setup.py install for mozlog 12:52:07 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Running setup.py install for moznetwork 12:52:07 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Running setup.py install for mozprocess 12:52:07 INFO - Running setup.py install for mozprofile 12:52:07 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:52:07 INFO - Running setup.py install for mozrunner 12:52:08 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:52:08 INFO - Running setup.py install for mozscreenshot 12:52:08 INFO - Running setup.py install for moztest 12:52:08 INFO - Running setup.py install for mozversion 12:52:08 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:52:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:52:08 INFO - Cleaning up... 12:52:08 INFO - Return code: 0 12:52:08 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:52:08 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')]} 12:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:08 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')]} 12:52:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:08 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 0x7f1bbae6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, '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': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', '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 12:52:08 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 12:52:08 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 12:52:08 INFO - Using env: {'DISPLAY': ':0', 12:52:08 INFO - 'HOME': '/home/cltbld', 12:52:08 INFO - 'LANG': 'en_US.UTF-8', 12:52:08 INFO - 'LANGUAGE': 'en_US:en', 12:52:08 INFO - 'LOGNAME': 'cltbld', 12:52:08 INFO - 'MAIL': '/var/mail/cltbld', 12:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:08 INFO - 'MOZ_NO_REMOTE': '1', 12:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:08 INFO - 'NO_EM_RESTART': '1', 12:52:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:08 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:08 INFO - 'SHELL': '/bin/bash', 12:52:08 INFO - 'SHLVL': '1', 12:52:08 INFO - 'TERM': 'linux', 12:52:08 INFO - 'TMOUT': '86400', 12:52:08 INFO - 'USER': 'cltbld', 12:52:08 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:08 INFO - '_': '/tools/buildbot/bin/python'} 12:52:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:52:08 INFO - Running setup.py (path:/tmp/pip-GfIlAt-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:52:08 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)) 12:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:52:08 INFO - Running setup.py (path:/tmp/pip-ICnt8D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:52:08 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)) 12:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:52:08 INFO - Running setup.py (path:/tmp/pip-pdU60c-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:52:08 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)) 12:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:52:08 INFO - Running setup.py (path:/tmp/pip-8vorPp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:52:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:52:08 INFO - Running setup.py (path:/tmp/pip-lalqIH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:52:08 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)) 12:52:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:52:08 INFO - Running setup.py (path:/tmp/pip-bNp0ai-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:52:09 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)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:52:09 INFO - Running setup.py (path:/tmp/pip-USvdef-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:52:09 INFO - Running setup.py (path:/tmp/pip-Lm1QM5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:52:09 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)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:52:09 INFO - Running setup.py (path:/tmp/pip-ka582X-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:52:09 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)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:52:09 INFO - Running setup.py (path:/tmp/pip-iZVDA0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:52:09 INFO - Running setup.py (path:/tmp/pip-iW_i_B-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:52:09 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)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:52:09 INFO - Running setup.py (path:/tmp/pip-ofhOOb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:52:09 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)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:52:09 INFO - Running setup.py (path:/tmp/pip-wylRGk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:52:09 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)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:52:09 INFO - Running setup.py (path:/tmp/pip-EMNxUx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:52:09 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)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:52:09 INFO - Running setup.py (path:/tmp/pip-2Rkj4V-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:52:09 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)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:52:09 INFO - Running setup.py (path:/tmp/pip-_oai2L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:52:09 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)) 12:52:09 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:52:09 INFO - Running setup.py (path:/tmp/pip-EE1koZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:52:09 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)) 12:52:09 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)) 12:52:09 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)) 12:52:09 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)) 12:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:52:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 12:52:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:11 INFO - Downloading blessings-1.5.1.tar.gz 12:52:11 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 12:52:11 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:52:11 INFO - Installing collected packages: blessings 12:52:11 INFO - Running setup.py install for blessings 12:52:11 INFO - Successfully installed blessings 12:52:11 INFO - Cleaning up... 12:52:11 INFO - Return code: 0 12:52:11 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:52:11 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:52:11 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:52:11 INFO - Reading from file tmpfile_stdout 12:52:11 INFO - Current package versions: 12:52:11 INFO - argparse == 1.2.1 12:52:11 INFO - blessings == 1.5.1 12:52:11 INFO - blobuploader == 1.2.4 12:52:11 INFO - docopt == 0.6.1 12:52:11 INFO - manifestparser == 1.1 12:52:11 INFO - mozInstall == 1.12 12:52:11 INFO - mozcrash == 0.16 12:52:11 INFO - mozdebug == 0.1 12:52:11 INFO - mozdevice == 0.47 12:52:11 INFO - mozfile == 1.2 12:52:11 INFO - mozhttpd == 0.7 12:52:11 INFO - mozinfo == 0.9 12:52:11 INFO - mozleak == 0.1 12:52:11 INFO - mozlog == 3.1 12:52:11 INFO - moznetwork == 0.27 12:52:11 INFO - mozprocess == 0.22 12:52:11 INFO - mozprofile == 0.27 12:52:11 INFO - mozrunner == 6.11 12:52:11 INFO - mozscreenshot == 0.1 12:52:11 INFO - mozsystemmonitor == 0.0 12:52:11 INFO - moztest == 0.7 12:52:11 INFO - mozversion == 1.4 12:52:11 INFO - psutil == 3.1.1 12:52:11 INFO - requests == 1.2.3 12:52:11 INFO - wsgiref == 0.1.2 12:52:11 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:11 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test-pgo/build/venv/cache', '--timeout', '120', '-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 0x7f1bbae6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, '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': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', '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 12:52:11 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 12:52:11 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 12:52:11 INFO - Using env: {'DISPLAY': ':0', 12:52:11 INFO - 'HOME': '/home/cltbld', 12:52:11 INFO - 'LANG': 'en_US.UTF-8', 12:52:11 INFO - 'LANGUAGE': 'en_US:en', 12:52:11 INFO - 'LOGNAME': 'cltbld', 12:52:11 INFO - 'MAIL': '/var/mail/cltbld', 12:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:11 INFO - 'MOZ_NO_REMOTE': '1', 12:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:11 INFO - 'NO_EM_RESTART': '1', 12:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:11 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:11 INFO - 'SHELL': '/bin/bash', 12:52:11 INFO - 'SHLVL': '1', 12:52:11 INFO - 'TERM': 'linux', 12:52:11 INFO - 'TMOUT': '86400', 12:52:11 INFO - 'USER': 'cltbld', 12:52:11 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:11 INFO - '_': '/tools/buildbot/bin/python'} 12:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:12 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)) 12:52:12 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)) 12:52:12 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)) 12:52:12 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)) 12:52:12 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)) 12:52:12 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)) 12:52:12 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)) 12:52:12 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)) 12:52:12 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)) 12:52:12 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)) 12:52:12 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)) 12:52:12 INFO - Cleaning up... 12:52:12 INFO - Return code: 0 12:52:12 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:52: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')]} 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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')]} 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52: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', '--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 0x7f1bbae6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, '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': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', '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 12:52:12 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 12:52:12 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 12:52:12 INFO - Using env: {'DISPLAY': ':0', 12:52:12 INFO - 'HOME': '/home/cltbld', 12:52:12 INFO - 'LANG': 'en_US.UTF-8', 12:52:12 INFO - 'LANGUAGE': 'en_US:en', 12:52:12 INFO - 'LOGNAME': 'cltbld', 12:52:12 INFO - 'MAIL': '/var/mail/cltbld', 12:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:12 INFO - 'MOZ_NO_REMOTE': '1', 12:52:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:12 INFO - 'NO_EM_RESTART': '1', 12:52:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:12 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:12 INFO - 'SHELL': '/bin/bash', 12:52:12 INFO - 'SHLVL': '1', 12:52:12 INFO - 'TERM': 'linux', 12:52:12 INFO - 'TMOUT': '86400', 12:52:12 INFO - 'USER': 'cltbld', 12:52:12 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:12 INFO - '_': '/tools/buildbot/bin/python'} 12:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:12 INFO - Downloading/unpacking jsonschema 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:52:14 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 12:52:14 INFO - Downloading/unpacking functools32 (from jsonschema) 12:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:14 INFO - Downloading functools32-3.2.3-2.tar.gz 12:52:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 12:52:14 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:52:14 INFO - warning: no files found matching '*.txt' 12:52:14 INFO - no previously-included directories found matching 'build' 12:52:14 INFO - no previously-included directories found matching 'dist' 12:52:14 INFO - no previously-included directories found matching '.git*' 12:52:14 INFO - Installing collected packages: jsonschema, functools32 12:52:14 INFO - Running setup.py install for functools32 12:52:14 INFO - warning: no files found matching '*.txt' 12:52:14 INFO - no previously-included directories found matching 'build' 12:52:14 INFO - no previously-included directories found matching 'dist' 12:52:14 INFO - no previously-included directories found matching '.git*' 12:52:14 INFO - Successfully installed jsonschema functools32 12:52:14 INFO - Cleaning up... 12:52:14 INFO - Return code: 0 12:52:14 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:52:14 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')]} 12:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:52:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:14 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')]} 12:52:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:52:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:52:14 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 0x7f1bbae6ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x242f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24fc600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, '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': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', '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 12:52:14 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 12:52:14 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 12:52:14 INFO - Using env: {'DISPLAY': ':0', 12:52:14 INFO - 'HOME': '/home/cltbld', 12:52:14 INFO - 'LANG': 'en_US.UTF-8', 12:52:14 INFO - 'LANGUAGE': 'en_US:en', 12:52:14 INFO - 'LOGNAME': 'cltbld', 12:52:14 INFO - 'MAIL': '/var/mail/cltbld', 12:52:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:14 INFO - 'MOZ_NO_REMOTE': '1', 12:52:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:14 INFO - 'NO_EM_RESTART': '1', 12:52:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:14 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:14 INFO - 'SHELL': '/bin/bash', 12:52:14 INFO - 'SHLVL': '1', 12:52:14 INFO - 'TERM': 'linux', 12:52:14 INFO - 'TMOUT': '86400', 12:52:14 INFO - 'USER': 'cltbld', 12:52:14 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:52:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:14 INFO - '_': '/tools/buildbot/bin/python'} 12:52:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:52:14 INFO - Downloading/unpacking flake8 12:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:52:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:52:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:52:16 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:52:16 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 12:52:16 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:52:16 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 12:52:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52:16 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 12:52:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52: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 12:52:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 12:52:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:52:17 INFO - no previously-included directories found matching 'docs/_build' 12:52:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:52:17 INFO - Running setup.py install for pep8 12:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:52:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:52:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:52:17 INFO - no previously-included directories found matching 'docs/_build' 12:52:17 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:52:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:52:17 INFO - Cleaning up... 12:52:17 INFO - Return code: 0 12:52:17 INFO - Running post-action listener: _resource_record_post_action 12:52:17 INFO - Running post-action listener: _start_resource_monitoring 12:52:17 INFO - Starting resource monitoring. 12:52:17 INFO - ##### 12:52:17 INFO - ##### Running install step. 12:52:17 INFO - ##### 12:52:17 INFO - Running pre-action listener: _resource_record_pre_action 12:52:17 INFO - Running main action method: install 12:52:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:52:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:52:17 INFO - Reading from file tmpfile_stdout 12:52:17 INFO - Detecting whether we're running mozinstall >=1.0... 12:52:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:52:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:52:17 INFO - Reading from file tmpfile_stdout 12:52:17 INFO - Output received: 12:52:17 INFO - Usage: mozinstall [options] installer 12:52:17 INFO - Options: 12:52:17 INFO - -h, --help show this help message and exit 12:52:17 INFO - -d DEST, --destination=DEST 12:52:17 INFO - Directory to install application into. [default: 12:52:17 INFO - "/builds/slave/test-pgo"] 12:52:17 INFO - --app=APP Application being installed. [default: firefox] 12:52:17 INFO - mkdir: /builds/slave/test-pgo/build/application 12:52:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:52:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:52:32 INFO - Reading from file tmpfile_stdout 12:52:32 INFO - Output received: 12:52:32 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:52:32 INFO - Running post-action listener: _resource_record_post_action 12:52:32 INFO - ##### 12:52:32 INFO - ##### Running run-tests step. 12:52:32 INFO - ##### 12:52:32 INFO - Running pre-action listener: _resource_record_pre_action 12:52:32 INFO - Running main action method: run_tests 12:52:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:52:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:52:32 INFO - Python 2.7.3 12:52:32 INFO - Return code: 0 12:52:32 INFO - grabbing minidump binary from tooltool 12:52:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:52:32 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 0x258b350>, '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 0x258c250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x258c6e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:52:32 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 12:52:32 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 12:52:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:52:32 INFO - Return code: 0 12:52:32 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:52:32 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:52:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:52:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:52:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:52:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:52:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:52:33 INFO - Return code: 0 12:52:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:52:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost 12:52:33 INFO - Using env: {'DISPLAY': ':0', 12:52:33 INFO - 'HOME': '/home/cltbld', 12:52:33 INFO - 'LANG': 'en_US.UTF-8', 12:52:33 INFO - 'LANGUAGE': 'en_US:en', 12:52:33 INFO - 'LOGNAME': 'cltbld', 12:52:33 INFO - 'MAIL': '/var/mail/cltbld', 12:52:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:52:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:52:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:52:33 INFO - 'MOZ_NO_REMOTE': '1', 12:52:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:52:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:52:33 INFO - 'NO_EM_RESTART': '1', 12:52:33 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:52:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:52:33 INFO - 'PWD': '/builds/slave/test-pgo', 12:52:33 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:52:33 INFO - 'SHELL': '/bin/bash', 12:52:33 INFO - 'SHLVL': '1', 12:52:33 INFO - 'TERM': 'linux', 12:52:33 INFO - 'TMOUT': '86400', 12:52:33 INFO - 'USER': 'cltbld', 12:52:33 INFO - 'XDG_SESSION_COOKIE': '6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838', 12:52:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:52:33 INFO - '_': '/tools/buildbot/bin/python'} 12:52:33 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost'] with output_timeout 3600 12:52:33 INFO - mozversion INFO | application_buildid: 20151128113004 12:52:33 INFO - mozversion INFO | application_changeset: 959df62d450d8d8d51252ba9c292b668835ac3e7 12:52:33 INFO - mozversion INFO | application_display_name: Nightly 12:52:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:52:33 INFO - mozversion INFO | application_name: Firefox 12:52:33 INFO - mozversion INFO | application_remotingname: firefox 12:52:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:52:33 INFO - mozversion INFO | application_vendor: Mozilla 12:52:33 INFO - mozversion INFO | application_version: 45.0a1 12:52:33 INFO - mozversion INFO | platform_buildid: 20151128113004 12:52:33 INFO - mozversion INFO | platform_changeset: 959df62d450d8d8d51252ba9c292b668835ac3e7 12:52:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:52:33 INFO - mozversion INFO | platform_version: 45.0a1 12:52:33 INFO - 2015-11-28 12:52:33,434 DEBUG : using testdate: 1448743953 12:52:33 INFO - 2015-11-28 12:52:33,434 DEBUG : actual date: 1448743953 12:52:33 INFO - 2015-11-28 12:52:33,443 INFO : starting webserver on 'localhost:51265' 12:52:33 INFO - 2015-11-28 12:52:33,444 INFO : Starting test suite talos-linux64-ix-007.e 12:52:33 INFO - 2015-11-28 12:52:33,444 INFO : Starting test dromaeo_css 12:52:33 INFO - 2015-11-28 12:52:33,444 DEBUG : operating with platform_type : linux_ 12:52:33 INFO - 2015-11-28 12:52:33,445 INFO : Initialising browser for dromaeo_css test... 12:52:33 INFO - 2015-11-28 12:52:33,459 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwGcIS9/profile http://localhost:51265/getInfo.html 12:52:38 INFO - 2015-11-28 12:52:38,146 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:52:38 INFO - 2015-11-28 12:52:38,146 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:52:38 INFO - 2015-11-28 12:52:38,146 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:52:38 INFO - 2015-11-28 12:52:38,146 DEBUG : BROWSER_OUTPUT: __metrics 12:52:39 INFO - 2015-11-28 12:52:39,150 INFO : Browser initialized. 12:52:39 INFO - 2015-11-28 12:52:39,150 INFO : Running cycle 1/1 for dromaeo_css test... 12:52:39 INFO - 2015-11-28 12:52:39,151 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpwGcIS9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:52:50 INFO - 2015-11-28 12:52:50,905 DEBUG : BROWSER_OUTPUT: RSS: Main: 140496896 12:52:50 INFO - 2015-11-28 12:52:50,905 DEBUG : BROWSER_OUTPUT: 12:53:40 INFO - 2015-11-28 12:53:40,525 DEBUG : BROWSER_OUTPUT: 1448744020524 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] 12:55:49 INFO - 2015-11-28 12:55:49,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51265/tests/dromaeo/cssquery-ext.html) 12:55:50 INFO - 2015-11-28 12:55:50,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 147599360 12:55:50 INFO - 2015-11-28 12:55:50,799 DEBUG : BROWSER_OUTPUT: 12:58:52 INFO - 2015-11-28 12:58:52,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-ext.html (next: http://localhost:51265/tests/dromaeo/cssquery-jquery.html) 12:58:53 INFO - 2015-11-28 12:58:53,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 143007744 12:58:53 INFO - 2015-11-28 12:58:53,344 DEBUG : BROWSER_OUTPUT: 13:01:55 INFO - 2015-11-28 13:01:55,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51265/tests/dromaeo/cssquery-mootools.html) 13:01:55 INFO - 2015-11-28 13:01:55,607 DEBUG : BROWSER_OUTPUT: RSS: Main: 144654336 13:01:55 INFO - 2015-11-28 13:01:55,607 DEBUG : BROWSER_OUTPUT: 13:04:57 INFO - 2015-11-28 13:04:57,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51265/tests/dromaeo/cssquery-prototype.html) 13:04:57 INFO - 2015-11-28 13:04:57,944 DEBUG : BROWSER_OUTPUT: RSS: Main: 142438400 13:04:57 INFO - 2015-11-28 13:04:57,944 DEBUG : BROWSER_OUTPUT: 13:08:00 INFO - 2015-11-28 13:08:00,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51265/tests/dromaeo/cssquery-yui.html) 13:08:00 INFO - 2015-11-28 13:08:00,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 141807616 13:08:00 INFO - 2015-11-28 13:08:00,868 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-11-28 13:11:03,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/dromaeo/cssquery-yui.html (next: http://localhost:51265/tests/dromaeo/cssquery-dojo.html) 13:11:03 INFO - 2015-11-28 13:11:03,715 DEBUG : BROWSER_OUTPUT: RSS: Main: 145182720 13:11:03 INFO - 2015-11-28 13:11:03,715 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-11-28 13:11:03,715 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:11:03 INFO - 2015-11-28 13:11:03,716 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:11:03 INFO - 2015-11-28 13:11:03,716 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:11:03 INFO - 2015-11-28 13:11:03,716 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:11:03 INFO - 2015-11-28 13:11:03,716 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3189.1708155879473;3262.8857989970343;3280.4751239801635;3297.818619975901;3314.2542927841237;5434.673919564819;5548.500634942854;5552.528035117015;5577.358603760569;5582.023145949458;5479.99999999999;5516.200150978106;5524.502794748471;5594.9089927464165;5604.243427137335;5000.874978125548;5084.3136176616235;5180.922286165692;5198.116320225552;5202.06362854686;5017.949820501784;5089.185730283156;5156.510131537498;5173.663711858717;5212.6611770235;4951.8514444566545;4996.625253106032;5059;5061.620378471593;5088.847334579968;5052.595792336604;5063.443021267658;5064.5441910228255;5067.746612669389;5113.846584602468;5009.4239162496415;5011.599072074226;5014.2979982802435;5035.723035233061;5043.470435604282;5212.374515058179;5257.263983042377;5272.103742363807;5286.524212820865;5358.4641535846495;6005.849853753647;6039.516838652941;6043.879122417571;6048.758049678007;6050.122732203849;6061.393860613947;6069.211002569682;6079.331273559905;6092.51259899207;6093.817185484442;5413.458654134594;5505.944940550623;5514.862128446781;5570.498655120978;5654.010548154098;6074.088886667036;6077.574569780073;6085.939140608626;6090.390960903874;6107.267127944675;5762.394948530344;5865.706714664249;5906.793262235801;5916.319623243296;5937.851553711192;5856.1508581255475;5928.614640048383;6023.909641355383;6024.939750602438;6083.391660833881;5679.460451257124;5695.8860822784145;5712.714364281769;5717.971410142923;5730.426957304237;5817.912731309034;5820.563457740686;5830.941690583125;5833.270841144857;5962.731677074542;4517.728936263835;4567.109413664303;4574.839880604163;4576.679632425698;4613.953860461353;4086.1214838809206;4106.548279689232;4110.362893751473;4113;4141;5556.055470570012;5595.720213989284;5618.325800903836;5753.395893431213;5767.769289228468;6054.697265136726;6057.091436284592;6060.666663333471;6065.696715164224;6101.725422356005;5735.942640573541;5740.626859254218;5744.913826292609;5757.0788673811985;5762.654240745569;5069.695818250917;5075.492450754895;5101.795928162832;5225.92161117576;5239.921401178985;5992.970035149883;6177.752889884354;6208.844778880474;6231.844203894939;6246.000639897686;6017.548683848817;6020.518358531394;6054.212952316171;6063.272407311151;6078.3921607838865;6013.188219590475;6022.337542870193;6100.664463454553;6119;6142.662153581417;5899.67551784656;5904.380040095728;5931.555133365101;5984.850378740566;5986.970065149821;5808.94191058084;6045.365236650265;6057.636541807506;6062.363451837494;6076.240469941257;5832.445917637818;5849.181114644039;5904.350521442724;5919.526437884872;5973.402659733992;5691.26013618227;5694.202811606461;5697.173909782975;5706.743196556248;5715.9142612860005;5578.888422231614;5617.325920889356;5622.32532096151;5685.60200785941;5787.189793428839;5755.510781583613;5811.157382179645;5865.648061116347;5874.295084589877;5874.911876321773;5625.521830644441;5660.943390566042;5666.9716651416475;5686.943130568807;5688.601797874109 13:11:03 INFO - 2015-11-28 13:11:03,716 DEBUG : BROWSER_OUTPUT: |1;ext.html;554.4344768336294;596.0701305962696;598.7096258314716;601.765311528504;607.9817605471836;30868.845655771718;40689.79655101724;41117.794411027906;41475.58524414759;41630.37554436678;42913.141737165315;43366.56633433665;43412;43437.56562434375;43735.562644373545;8997.550122493865;9158.221551168159;9176.724698259062;9188.540572971324;9209.079092090804;8795.648174073029;8810.38327317088;8852.645894164225;8877.778055548599;8877.95561022194;8868.201861832435;8966.596503157341;8978.191962723353;8983.146601072887;8987.685431009915;8890.110988901122;8958.148975847284;8983.505907175102;8985;8996.685116020908;8755.649774009033;8883.067277935788;8905.243054340324;8965.596548155349;8968.820623587491;40591.39112913309;40899.182016359504;40925.18149636991;41221;41246.58753412458;3404.9489257661153;3490.3542844573835;3540.539729835105;3679.797611131387;3933.115049113955;30146.0956171313;30489.847550762104;30688.38623227523;30743;30821.229469263224;3395.3548825723033;3415.52182694423;3481.1993241554333;3547.18414764603;3616.3129005488872;293430;295333;295456;295593;295957;58602;59539;62788.37211627825;67228;67397.66301168462;64673.67663161654;64918.675406622664;64998.67500662561;65254.67372663201;65268.67365663236;15791.684166316609;15846.841531584536;15937.601559961095;15955.840441595668;15978;12367.69080772988;12522.812157817458;12581.93709031449;12583.937080314723;12627.43176557057;21100.683489747666;21265.36203913854;21281.148754049664;21331.78668213329;21388.679169812465;8141;8422.747317580483;8476.618552165044;8495.95752021236;8620.568971551398;1037.5642230263309;1054.0671505717496;1070.7269646240159;1160.6053941659877;1182.846229990113;33435.66564334326;34153;34168;34336.82831585826;34441.31117377638;1036.3419228789621;1050.4275170032352;1054.4727636181908;1083.8428427877914;1147.4320211495362;14810.777838332433;16978.830211697725;17114;17366;17386.565335866453;442233;442245;445444;445819;446280;56165.71917140388;56305.71847140738;56524.15213771797;56644.15033774497;56892.43107568871;1351.2568087551808;1381.3852835488312;1384.0657556149558;1394.3864699532173;1399.4612074351448;29081.272968175967;30401.695983040772;31905;32545.674543254263;33180.66819331872;52122;53065.469345307596;53133.20300195423;53263.733681331345;53322.73338633282;308471;311802;312035;312378;312572;42553.787231063645;46739;47123.29315060345;47456.288155677;47865.76067119642;45074.098518030114;45187.54812451833;45436.54563454323;45981;46045.53954460412;37818;38007.42988855114;38946.6105338943;39012.80493597514;39227.01932451712;37360.25279494449;38381.61618383892;38684.6131538681;41507.792461037505;42455;38816;40202.59797401988;40894.591054089076;40901.1819763609;41031;30268.84865575746;31749.206269842514;34452.48321275233;35677;38696.226075478895;26120.608190876774;26448.8677556611;26575;26685.733142668323;26843.328916776456 13:11:03 INFO - 2015-11-28 13:11:03,716 DEBUG : BROWSER_OUTPUT: |2;jquery.html;353.4592074126587;358.3907357492262;358.4909428611372;360.15004589169564;360.16441854896635;16420.753688694665;16615.584610384747;17388.91305543472;17394.739078913826;18038.5490362741;10749.785004299909;11630.651080467578;15965.441209557639;15981.360745570164;16015;4691.953080469203;4894.583960363373;4904.773806548363;4915.606751459874;4921.212605983043;4836.226203807391;4867.659263851532;4907.975460122712;4908.779104940286;4910.386201724785;4927.113119638464;4945.604351651859;5096.694198348111;5235.057689615867;5269.209618557228;5208.817691380802;5229.1633338666015;5233.869153271161;5239.607029472805;5260.473952604728;5057.595392368602;5282.788688452457;5290.470952904679;5291.788328466857;5322.946770532284;19330;19400.902995484932;19509.414717558495;19795.703064454046;19899.403017909484;2105.26315789474;2182.7380714314386;2189.0074188532053;2192.7478339990944;2197.8901054947187;9273.489958052372;9300.581473833694;9355.578998944995;9544.42733435996;9699.951500242525;1776.5736223306442;1848.3161230344858;1881.7177423386465;1886.528367908023;1891.6122194950003;60017.399826001616;62076.37923620796;62631.686841565956;63365.68317158385;64297.35702642961;9463.391223492023;9814.362066465657;10119.747006324753;10136.493175341204;10180.440075795903;13173.736525269633;13210.537631183055;13223;13258.204507729568;13284.136531125447;7524.360429363456;7645.235476452311;7697.268759467842;7774.611269436618;7828.647710853025;7625.389968802482;7659.234076592296;7663.6168191590195;7701.614919254015;7714.807129821799;4304.698671092993;4349.434573505424;4350.651947844165;4366.388705581221;4397.878540972096;1733.8352856478614;1735.6788994036144;1760.4630587670883;1772.3265159239406;1774.0774797105432;414.6889832625531;425.15818679015723;430.8922769307673;450.8129126412568;941.289326558444;14855.331510082073;16445.342186312653;17507.38724144649;17857.732134018;18134.81865181331;919.6091661044029;937.5218638494281;939.196986576481;950.4297421547017;963.3689933093834;9723.367981081206;9887.505624718735;9916.454594997344;9924.751881203028;9946.35348702332;599557;599618;601814;624221.9411350086;626767.5909168196;84298;85063.14936850552;85228.57385713156;85482.57258713791;86045.56977215073;1171.29722166701;1180.9232399894152;1182.408795602199;1184.5498710489958;1186.1756079524648;15452.84547154559;15485.148316842682;15497.225138743242;15738.685226295638;15874.285657145687;32200;33723.83138084392;34120.829395853856;34753.30493390169;35837;41039.17921641491;41340;41667.58332416637;42538;43582.56417435785;8960.372773906025;9048.773780655536;9243.445393276425;9351.39215950961;9359.344845860724;12622.495100195889;16692.332306707594;16873.493795186165;17217.655646887244;17298.394556190473;14100;14641.926790366406;14771.852281477477;14856.257187140816;15117.773233401287;13607.115537490032;13892.16647001183;14002.299885005505;14174.503892363718;14177.291135443393;14240.430382784987;14284.500042498463;14698.41206351734;14884.330205140577;15223.543293701206;9492.382995105296;9655.662051828152;9749.512524373895;9797.363171393836;9823.508824558887;9968.700938971842;10066.396016239049;14080;14240.786388203978;14883.25583720788 13:11:03 INFO - 2015-11-28 13:11:03,716 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1509.433962264151;1677.4883660483556;1748.4317596781045;1751.696519077413;1778.546470649984;7273.16358618759;7330.633468326589;7669.309762121408;7696.114946781122;7727;7657.081150261963;7674;7718.151003389623;7742.574158421298;7766;2276.4195130241806;2287.553926984239;2296.5866144094057;2300.67790509328;2312.6762253284555;2231;2262.2534563593977;2269.6822444857735;2270.8069814065743;2273.874936878471;2245.6856040154394;2252.414372263207;2272.6704627828954;2280.384296240014;2300.9884950575306;2177.412098733333;2243.2372993182316;2249.2352600115873;2258.1870526610405;2271.4094335472732;2302.481941563152;2323.7211534615953;2324.4653729642278;2325.3372788755123;2330.9300720978226;7398.519096258726;7468.514546554511;7498.775036748906;7503.5497870127965;7503.587302698349;4481.215787237253;4567.246404343279;4583.885402864922;4592.15045216636;4595.195840727859;2987.9402411951855;3014.9397012059635;3095.876164953399;3098.380323935222;3136.9843150784327;1040.380973320873;1043.7390652336917;1750.9037002964833;1784.5003399048157;1785.5357607022138;9920.900790992142;10036.046575575381;10046.69859904204;10083.294169408144;10157.54291056897;4044.2113787811095;4063.187362527506;4104;4109.856155034559;4129.814158362881;8206.712765053315;8221.917780822236;8244.752657420288;8269.95865020671;8276.917230827736;4484.506704262529;4536.432945881765;4563.794629241692;4576.81692732287;4594.839180628662;4160.563140870226;4224.8732538023905;4233;4257.212415703105;4257.936130958038;3375.223698549298;3381.814000229962;3383.052745231339;3394.5587073680263;3400.4219282721997;1057.4025675493322;1069;1074.4520294649628;1079.6275285026654;1082.967510974672;1012.3824467075078;1060.9814578005048;1072.7425417899804;1130.383940752292;1301.3038024656764;7021.052157958712;7045.189803172599;7077.858442831114;7089.82275443118;7092.397146242524;594.5689375202943;756.3117563017628;1205.4695933789105;1231.2858542045772;1244.2037096258402;5641.576881733804;5676.8864622707315;5685.943140568541;5708.571857110734;5727.284089488814;8672.132786721277;8706.390552661253;8792.296616270683;8813.955930220436;8934;8601.870971935426;8627.396082274181;8637.740867773977;8719.825603488021;8747.956260218785;7035.683394247271;7049.894251586128;7080.327368899946;7158.391536719437;7204.891926621;7137.10786151731;7148.678309475982;7154.785356439315;7166;7186.568805871664;7925.564093974886;7981.241782030698;8009.399295053011;8135;8158.510489370657;8109.351251899716;8153.959230203811;8212.13772553897;8220.83558328818;8249.133840946613;6543.70553325111;6564.540482166202;6804.21751498584;6826.385625293748;6835.282295358916;7306.488545801955;7308.744193953186;7317.67070481819;7335.816604584928;7349.77950661481;6726;6778.3221677831825;6959.19969203548;6978.47661425385;7033.753818616324;6601.834954126185;6727.596344219362;6762.966185169043;6771.796846094625;6780.084688566981;6673.532852700265;6708.798736037927;6710.765123220664;6711.295313991961;6724.831879203059;5927;6050.485708714808;6060.393960603904;6064.787732429344;6267.310595834363;6283.937160628335;6300.495960323072;6326.841828954129;6330.683465826783;6341 13:11:03 INFO - 2015-11-28 13:11:03,716 DEBUG : BROWSER_OUTPUT: |4;prototype.html;334.8995301409577;338.3875185913497;339.06418285531953;344.60542678632976;350.40256362901255;6275.8117256482265;6306.085617585447;6333.968330158348;6409.038644203371;6512.251091124522;6293.874122517547;6333.398327158924;6336;6342.936570634292;6346.397092276238;4746.620270378378;4779.976100119512;4786.52134786522;4794.87320479687;4800.303955926389;4784.688995215317;4790.113828941657;4794.544518270776;4801.8079276828885;4809.254565542329;4622.791974361145;4731.053789242148;4736.2895565665085;4737;4742.739149346785;4713.92929106062;4725.3148293497425;4728.172569800271;4746.382970213867;4753.786079626425;4078.1028173801715;4084.9387259191135;4085;4090.3864420337186;4099.97950010251;5948.345681974979;5973.6415815050805;5983.910241346383;6005.159277701126;6014.669193194372;5357.946420535784;5482.424345443751;5509.724513774296;5535.972320138373;5554.305711786027;6719.496037797136;6726.12560367154;6727.932720672779;6731.730730770763;6731.831704207385;4508.5266047064915;4510.797014134372;4515.63874890008;4519.502854685982;4521.208788462006;6773.45812335012;6923.792286231421;6945.965270173668;6947.826304342381;6983.895241571431;4652.930206046912;4671.719696818202;4672.369230153886;4675.275332323496;4680.3915490985955;4731.361266229083;4733.100710864925;4737.028909073701;4738.099761045391;4742.952570474251;5495.450454954553;5507.449255074541;5511.283533140666;5514.503694667499;5518.172274158908;6601.70292336846;6690.264070952191;6705.798826035227;6724.260331363546;6742.9662851685425;1631.9428819991244;1663.434432293002;1665.192381694877;1679.9748003779953;1681.0334057916746;1096.4682129167347;1096.5942601237593;1111.6831702964616;1116.1015382616908;1121.7532142928542;6398.8080357588415;6463.741450342028;6468.320826313169;6482.351764823574;6483.384078512534;6836.145481814773;6852.760153394607;6860.897086543706;6898.965505172442;6902.102726645504;6313.210848643919;6417.96791016042;6424.068510066014;6450.322716114741;6457.451116655043;3766.114962983697;3801.3727734923427;3816.160444702161;3818.4463252828186;3825.1202223488754;7244;7273.89089163663;7281.635918204069;7287.890681639779;7308.37878780299;6942.271061538567;7151.392131668762;7186.964065179641;7196.424286057103;7206.243344448862;7234.819129521804;7257.818554536285;7260.382867456326;7279.1265048194555;7285.672144753499;7003.26465721092;7004.894926576208;7007.299270072952;7009.334113259232;7021.754238601625;6719.26088130315;6851.663925534473;6872.587644741331;6888.483363747639;6903.93096069053;7265.600391978492;7272.854542909006;7280.453965952469;7282.854342913006;7296.452766042462;4631.980964187874;4667.089917466062;4667.113248482778;4672.719636821802;4673.929891051569;6806.523543351917;6844.076049733222;6928.688209030505;6974.721011159497;6981.197162326397;6779.35596118368;6804.6257455840405;6804.727810887509;6820.931790682228;6839.247682754993;6706.597604143767;6742.69657865407;6753.264927704287;6766.86466270662;6778.694958726771;6512.967435162794;6646.83382915431;6660.933390666031;6664.5668031579735;6690.899636505554;6805.217399999064;6834.931650683429;6847.281035491202;6852.143482064742;6852.657367131723;6626.105475760904;6661.267260601233;6682.866342673216;6687.364700353459;6688.83277918056 13:11:03 INFO - 2015-11-28 13:11:03,717 DEBUG : BROWSER_OUTPUT: |5;yui.html;769.6036541181293;809.4050872608632;809.6194788449428;839.9664013439462;876.7764220123868;13682.657933551665;13711.725765484684;13901.374438150282;13924.791128133085;13959.860401395996;13415;13461.1923284603;13482.93258533706;13540.661483462918;13564.389602467889;830.8296799156174;840.6175190288404;849.9150084991513;851.6508231625035;853.5646820121751;835.1147783349638;843.3548335523299;854.2994744309668;855.1234984141242;856.6701819799359;885.2961895293257;895.8253140637578;900.275278400887;901.5492253873064;902.0303174087849;881.0704706534603;885.4642941020686;890.6838072484304;892.4243862708549;893.1693525021727;652.6801867085142;655.4625207329991;658.6344578758788;659.2056571830932;660.1780782925241;13058.934705326508;13092.934535327262;13110;13208.933955330258;13215.273159976197;12108.57619983305;12563.434645440886;12765.93617031909;12871;12903.806442903364;10262.794744105151;10340.482975851253;10379.896201038044;10810.72973175669;10917.39954302513;3589.766665166756;3649.59854416014;3687.225682606629;3688.4467329900463;3762;48740.26889596659;49613.50386496125;49632.50367496315;49697;49766.7511662443;10068.231236410045;10091.293609447415;10200.28597998133;10360;10435.634752783617;17491.737623935398;17599.560010999572;17605.471835844946;17653.205605747517;17676.558086047695;7606.467547271638;7706.807329816687;7754.651040703182;7757.301842834172;7763.72826951054;4146.91706165881;4182.853600123981;4199.139176468817;4227.492700875853;4257.212415703105;3109.7978631388887;3151.7636177286795;3156.71589556941;3178.936421271562;3182.124915648169;551.8013515134548;566.3260719743492;567.7274908044079;571.5313442976802;574.4427904932209;652.8367908022994;685.4550632247375;691.5574032619128;696.4428457234294;707.3916431868589;7769.922300777033;8025;8472;8616.353773467015;8631.956840215758;566.5326105962597;571.9571032172604;700.3906601256838;718.0542916672812;733.4719002318429;3900.90247743803;4208.410822484854;4227.619514243671;4239.915201695949;4276.893077673083;54989;55646.443535564125;55912.44087559072;56151;57490.13764793531;49394.259086113736;49955;51136;52244.738776306636;54931.176032359544;51957.96084078373;52210;52562.211566826525;53064.73467632637;53213.20180197222;8301.418900676894;8586.184312490303;8631.95684021601;8916.33127515426;9431.104045115702;33980.49029264612;34871.47692784559;35468.645313546534;35475.82262088673;35878.820605896806;44559.55440445684;45502.77248613736;45738.54261457476;45806.31290530578;46196;11450.770984580427;11731.589394371498;11765.294082354743;12035.75928481408;12190.939045304716;12102.75794484123;12227.938860305641;12340.629781106582;12858.42137103814;13344.599662010156;11202;11502.252353596989;11542.59600913964;11862.578647758053;12280.508779649072;11504.714640198512;11559.942200288944;11963.162578619413;12361.752764944831;12368.814467782811;10659.520321585702;11326.886731132583;11349.54601815918;11640;12176.269423834598;10208.183345332207;10264.589416423558;10294.168652730457;10445.9477702611;10852.077573406033;9221.677241296522;9873;10024.649137280161;10114.533392657877;10284.537195826355 13:11:03 INFO - 2015-11-28 13:11:03,717 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,302 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: __startTimestamp1448745063708__endTimestamp 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: Number of tests: 6 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5529.75 Median:5706.74 stddev:623.31 (10.9%) stddev-sans-first:597.57 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: Values: 3189.2 3262.9 3280.5 3297.8 3314.3 5434.7 5548.5 5552.5 5577.4 5582.0 5480.0 5516.2 5524.5 5594.9 5604.2 5000.9 5084.3 5180.9 5198.1 5202.1 5017.9 5089.2 5156.5 5173.7 5212.7 4951.9 4996.6 5059.0 5061.6 5088.8 5052.6 5063.4 5064.5 5067.7 5113.8 5009.4 5011.6 5014.3 5035.7 5043.5 5212.4 5257.3 5272.1 5286.5 5358.5 6005.8 6039.5 6043.9 6048.8 6050.1 6061.4 6069.2 6079.3 6092.5 6093.8 5413.5 5505.9 5514.9 5570.5 5654.0 6074.1 6077.6 6085.9 6090.4 6107.3 5762.4 5865.7 5906.8 5916.3 5937.9 5856.2 5928.6 6023.9 6024.9 6083.4 5679.5 5695.9 5712.7 5718.0 5730.4 5817.9 5820.6 5830.9 5833.3 5962.7 4517.7 4567.1 4574.8 4576.7 4614.0 4086.1 4106.5 4110.4 4113.0 4141.0 5556.1 5595.7 5618.3 5753.4 5767.8 6054.7 6057.1 6060.7 6065.7 6101.7 5735.9 5740.6 5744.9 5757.1 5762.7 5069.7 5075.5 5101.8 5225.9 5239.9 5993.0 6177.8 6208.8 6231.8 6246.0 6017.5 6020.5 6054.2 6063.3 6078.4 6013.2 6022.3 6100.7 6119.0 6142.7 5899.7 5904.4 5931.6 5984.9 5987.0 5808.9 6045.4 6057.6 6062.4 6076.2 5832.4 5849.2 5904.4 5919.5 5973.4 5691.3 5694.2 5697.2 5706.7 5715.9 5578.9 5617.3 5622.3 5685.6 5787.2 5755.5 5811.2 5865.6 5874.3 5874.9 5625.5 5660.9 5667.0 5686.9 5688.6 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-11-28 13:11:03,718 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:53067.21 Median:40396.99 stddev:93819.39 (232.2%) stddev-sans-first:93999.73 13:11:03 INFO - 2015-11-28 13:11:03,722 DEBUG : BROWSER_OUTPUT: Values: 554.4 596.1 598.7 601.8 608.0 30868.8 40689.8 41117.8 41475.6 41630.4 42913.1 43366.6 43412.0 43437.6 43735.6 8997.6 9158.2 9176.7 9188.5 9209.1 8795.6 8810.4 8852.6 8877.8 8878.0 8868.2 8966.6 8978.2 8983.1 8987.7 8890.1 8958.1 8983.5 8985.0 8996.7 8755.6 8883.1 8905.2 8965.6 8968.8 40591.4 40899.2 40925.2 41221.0 41246.6 3404.9 3490.4 3540.5 3679.8 3933.1 30146.1 30489.8 30688.4 30743.0 30821.2 3395.4 3415.5 3481.2 3547.2 3616.3 293430.0 295333.0 295456.0 295593.0 295957.0 58602.0 59539.0 62788.4 67228.0 67397.7 64673.7 64918.7 64998.7 65254.7 65268.7 15791.7 15846.8 15937.6 15955.8 15978.0 12367.7 12522.8 12581.9 12583.9 12627.4 21100.7 21265.4 21281.1 21331.8 21388.7 8141.0 8422.7 8476.6 8496.0 8620.6 1037.6 1054.1 1070.7 1160.6 1182.8 33435.7 34153.0 34168.0 34336.8 34441.3 1036.3 1050.4 1054.5 1083.8 1147.4 14810.8 16978.8 17114.0 17366.0 17386.6 442233.0 442245.0 445444.0 445819.0 446280.0 56165.7 56305.7 56524.2 56644.2 56892.4 1351.3 1381.4 1384.1 1394.4 1399.5 29081.3 30401.7 31905.0 32545.7 33180.7 52122.0 53065.5 53133.2 53263.7 53322.7 308471.0 311802.0 312035.0 312378.0 312572.0 42553.8 46739.0 47123.3 47456.3 47865.8 45074.1 45187.5 45436.5 45981.0 46045.5 37818.0 38007.4 38946.6 39012.8 39227.0 37360.3 38381.6 38684.6 41507.8 42455.0 38816.0 40202.6 40894.6 40901.2 41031.0 30268.8 31749.2 34452.5 35677.0 38696.2 26120.6 26448.9 26575.0 26685.7 26843.3 13:11:03 INFO - 2015-11-28 13:11:03,722 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-11-28 13:11:03,722 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:30694.77 Median:21046.37 stddev:99763.66 (474.0%) stddev-sans-first:100017.50 13:11:03 INFO - 2015-11-28 13:11:03,722 DEBUG : BROWSER_OUTPUT: Values: 353.5 358.4 358.5 360.2 360.2 16420.8 16615.6 17388.9 17394.7 18038.5 10749.8 11630.7 15965.4 15981.4 16015.0 4692.0 4894.6 4904.8 4915.6 4921.2 4836.2 4867.7 4908.0 4908.8 4910.4 4927.1 4945.6 5096.7 5235.1 5269.2 5208.8 5229.2 5233.9 5239.6 5260.5 5057.6 5282.8 5290.5 5291.8 5322.9 19330.0 19400.9 19509.4 19795.7 19899.4 2105.3 2182.7 2189.0 2192.7 2197.9 9273.5 9300.6 9355.6 9544.4 9700.0 1776.6 1848.3 1881.7 1886.5 1891.6 60017.4 62076.4 62631.7 63365.7 64297.4 9463.4 9814.4 10119.7 10136.5 10180.4 13173.7 13210.5 13223.0 13258.2 13284.1 7524.4 7645.2 7697.3 7774.6 7828.6 7625.4 7659.2 7663.6 7701.6 7714.8 4304.7 4349.4 4350.7 4366.4 4397.9 1733.8 1735.7 1760.5 1772.3 1774.1 414.7 425.2 430.9 450.8 941.3 14855.3 16445.3 17507.4 17857.7 18134.8 919.6 937.5 939.2 950.4 963.4 9723.4 9887.5 9916.5 9924.8 9946.4 599557.0 599618.0 601814.0 624221.9 626767.6 84298.0 85063.1 85228.6 85482.6 86045.6 1171.3 1180.9 1182.4 1184.5 1186.2 15452.8 15485.1 15497.2 15738.7 15874.3 32200.0 33723.8 34120.8 34753.3 35837.0 41039.2 41340.0 41667.6 42538.0 43582.6 8960.4 9048.8 9243.4 9351.4 9359.3 12622.5 16692.3 16873.5 17217.7 17298.4 14100.0 14641.9 14771.9 14856.3 15117.8 13607.1 13892.2 14002.3 14174.5 14177.3 14240.4 14284.5 14698.4 14884.3 15223.5 9492.4 9655.7 9749.5 9797.4 9823.5 9968.7 10066.4 14080.0 14240.8 14883.3 13:11:03 INFO - 2015-11-28 13:11:03,722 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-11-28 13:11:03,722 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5281.10 Median:6062.59 stddev:2643.59 (43.6%) stddev-sans-first:2635.80 13:11:03 INFO - 2015-11-28 13:11:03,723 DEBUG : BROWSER_OUTPUT: Values: 1509.4 1677.5 1748.4 1751.7 1778.5 7273.2 7330.6 7669.3 7696.1 7727.0 7657.1 7674.0 7718.2 7742.6 7766.0 2276.4 2287.6 2296.6 2300.7 2312.7 2231.0 2262.3 2269.7 2270.8 2273.9 2245.7 2252.4 2272.7 2280.4 2301.0 2177.4 2243.2 2249.2 2258.2 2271.4 2302.5 2323.7 2324.5 2325.3 2330.9 7398.5 7468.5 7498.8 7503.5 7503.6 4481.2 4567.2 4583.9 4592.2 4595.2 2987.9 3014.9 3095.9 3098.4 3137.0 1040.4 1043.7 1750.9 1784.5 1785.5 9920.9 10036.0 10046.7 10083.3 10157.5 4044.2 4063.2 4104.0 4109.9 4129.8 8206.7 8221.9 8244.8 8270.0 8276.9 4484.5 4536.4 4563.8 4576.8 4594.8 4160.6 4224.9 4233.0 4257.2 4257.9 3375.2 3381.8 3383.1 3394.6 3400.4 1057.4 1069.0 1074.5 1079.6 1083.0 1012.4 1061.0 1072.7 1130.4 1301.3 7021.1 7045.2 7077.9 7089.8 7092.4 594.6 756.3 1205.5 1231.3 1244.2 5641.6 5676.9 5685.9 5708.6 5727.3 8672.1 8706.4 8792.3 8814.0 8934.0 8601.9 8627.4 8637.7 8719.8 8748.0 7035.7 7049.9 7080.3 7158.4 7204.9 7137.1 7148.7 7154.8 7166.0 7186.6 7925.6 7981.2 8009.4 8135.0 8158.5 8109.4 8154.0 8212.1 8220.8 8249.1 6543.7 6564.5 6804.2 6826.4 6835.3 7306.5 7308.7 7317.7 7335.8 7349.8 6726.0 6778.3 6959.2 6978.5 7033.8 6601.8 6727.6 6763.0 6771.8 6780.1 6673.5 6708.8 6710.8 6711.3 6724.8 5927.0 6050.5 6060.4 6064.8 6267.3 6283.9 6300.5 6326.8 6330.7 6341.0 13:11:03 INFO - 2015-11-28 13:11:03,723 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-11-28 13:11:03,723 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5605.57 Median:6413.50 stddev:1724.34 (26.9%) stddev-sans-first:1683.19 13:11:03 INFO - 2015-11-28 13:11:03,724 DEBUG : BROWSER_OUTPUT: Values: 334.9 338.4 339.1 344.6 350.4 6275.8 6306.1 6334.0 6409.0 6512.3 6293.9 6333.4 6336.0 6342.9 6346.4 4746.6 4780.0 4786.5 4794.9 4800.3 4784.7 4790.1 4794.5 4801.8 4809.3 4622.8 4731.1 4736.3 4737.0 4742.7 4713.9 4725.3 4728.2 4746.4 4753.8 4078.1 4084.9 4085.0 4090.4 4100.0 5948.3 5973.6 5983.9 6005.2 6014.7 5357.9 5482.4 5509.7 5536.0 5554.3 6719.5 6726.1 6727.9 6731.7 6731.8 4508.5 4510.8 4515.6 4519.5 4521.2 6773.5 6923.8 6946.0 6947.8 6983.9 4652.9 4671.7 4672.4 4675.3 4680.4 4731.4 4733.1 4737.0 4738.1 4743.0 5495.5 5507.4 5511.3 5514.5 5518.2 6601.7 6690.3 6705.8 6724.3 6743.0 1631.9 1663.4 1665.2 1680.0 1681.0 1096.5 1096.6 1111.7 1116.1 1121.8 6398.8 6463.7 6468.3 6482.4 6483.4 6836.1 6852.8 6860.9 6899.0 6902.1 6313.2 6418.0 6424.1 6450.3 6457.5 3766.1 3801.4 3816.2 3818.4 3825.1 7244.0 7273.9 7281.6 7287.9 7308.4 6942.3 7151.4 7187.0 7196.4 7206.2 7234.8 7257.8 7260.4 7279.1 7285.7 7003.3 7004.9 7007.3 7009.3 7021.8 6719.3 6851.7 6872.6 6888.5 6903.9 7265.6 7272.9 7280.5 7282.9 7296.5 4632.0 4667.1 4667.1 4672.7 4673.9 6806.5 6844.1 6928.7 6974.7 6981.2 6779.4 6804.6 6804.7 6820.9 6839.2 6706.6 6742.7 6753.3 6766.9 6778.7 6513.0 6646.8 6660.9 6664.6 6690.9 6805.2 6834.9 6847.3 6852.1 6852.7 6626.1 6661.3 6682.9 6687.4 6688.8 13:11:03 INFO - 2015-11-28 13:11:03,724 DEBUG : BROWSER_OUTPUT: 13:11:03 INFO - 2015-11-28 13:11:03,724 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14124.99 Median:4248.56 stddev:16343.42 (384.7%) stddev-sans-first:16358.49 13:11:03 INFO - 2015-11-28 13:11:03,725 DEBUG : BROWSER_OUTPUT: Values: 769.6 809.4 809.6 840.0 876.8 13682.7 13711.7 13901.4 13924.8 13959.9 13415.0 13461.2 13482.9 13540.7 13564.4 830.8 840.6 849.9 851.7 853.6 835.1 843.4 854.3 855.1 856.7 885.3 895.8 900.3 901.5 902.0 881.1 885.5 890.7 892.4 893.2 652.7 655.5 658.6 659.2 660.2 13058.9 13092.9 13110.0 13208.9 13215.3 12108.6 12563.4 12765.9 12871.0 12903.8 10262.8 10340.5 10379.9 10810.7 10917.4 3589.8 3649.6 3687.2 3688.4 3762.0 48740.3 49613.5 49632.5 49697.0 49766.8 10068.2 10091.3 10200.3 10360.0 10435.6 17491.7 17599.6 17605.5 17653.2 17676.6 7606.5 7706.8 7754.7 7757.3 7763.7 4146.9 4182.9 4199.1 4227.5 4257.2 3109.8 3151.8 3156.7 3178.9 3182.1 551.8 566.3 567.7 571.5 574.4 652.8 685.5 691.6 696.4 707.4 7769.9 8025.0 8472.0 8616.4 8632.0 566.5 572.0 700.4 718.1 733.5 3900.9 4208.4 4227.6 4239.9 4276.9 54989.0 55646.4 55912.4 56151.0 57490.1 49394.3 49955.0 51136.0 52244.7 54931.2 51958.0 52210.0 52562.2 53064.7 53213.2 8301.4 8586.2 8632.0 8916.3 9431.1 33980.5 34871.5 35468.6 35475.8 35878.8 44559.6 45502.8 45738.5 45806.3 46196.0 11450.8 11731.6 11765.3 12035.8 12190.9 12102.8 12227.9 12340.6 12858.4 13344.6 11202.0 11502.3 11542.6 11862.6 12280.5 11504.7 11559.9 11963.2 12361.8 12368.8 10659.5 11326.9 11349.5 11640.0 12176.3 10208.2 10264.6 10294.2 10445.9 10852.1 9221.7 9873.0 10024.6 10114.5 10284.5 13:11:03 INFO - 2015-11-28 13:11:03,725 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:11:03 INFO - 2015-11-28 13:11:03,725 DEBUG : BROWSER_OUTPUT: 13:11:04 INFO - 2015-11-28 13:11:04,438 INFO : Browser exited with error code: 0 13:11:04 INFO - 2015-11-28 13:11:04,457 INFO : Completed test dromaeo_css (00:18:31) 13:11:04 INFO - 2015-11-28 13:11:04,457 INFO : Starting test kraken 13:11:04 INFO - 2015-11-28 13:11:04,457 DEBUG : operating with platform_type : linux_ 13:11:04 INFO - 2015-11-28 13:11:04,457 INFO : Initialising browser for kraken test... 13:11:04 INFO - 2015-11-28 13:11:04,463 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ6wE7b/profile http://localhost:51265/getInfo.html 13:11:09 INFO - 2015-11-28 13:11:09,139 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:11:09 INFO - 2015-11-28 13:11:09,139 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:11:09 INFO - 2015-11-28 13:11:09,139 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:11:09 INFO - 2015-11-28 13:11:09,139 DEBUG : BROWSER_OUTPUT: __metrics 13:11:10 INFO - 2015-11-28 13:11:10,118 INFO : Browser initialized. 13:11:10 INFO - 2015-11-28 13:11:10,118 INFO : Running cycle 1/1 for kraken test... 13:11:10 INFO - 2015-11-28 13:11:10,119 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQ6wE7b/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:11:21 INFO - 2015-11-28 13:11:21,823 DEBUG : BROWSER_OUTPUT: RSS: Main: 138760192 13:11:21 INFO - 2015-11-28 13:11:21,823 DEBUG : BROWSER_OUTPUT: 13:11:24 INFO - 2015-11-28 13:11:24,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51265/tests/kraken/driver.html?testName=audio-beat-detection) 13:11:24 INFO - 2015-11-28 13:11:24,960 DEBUG : BROWSER_OUTPUT: RSS: Main: 140865536 13:11:24 INFO - 2015-11-28 13:11:24,960 DEBUG : BROWSER_OUTPUT: 13:11:27 INFO - 2015-11-28 13:11:27,610 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51265/tests/kraken/driver.html?testName=audio-dft) 13:11:28 INFO - 2015-11-28 13:11:28,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 141058048 13:11:28 INFO - 2015-11-28 13:11:28,203 DEBUG : BROWSER_OUTPUT: 13:11:31 INFO - 2015-11-28 13:11:31,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51265/tests/kraken/driver.html?testName=audio-fft) 13:11:31 INFO - 2015-11-28 13:11:31,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 135086080 13:11:31 INFO - 2015-11-28 13:11:31,623 DEBUG : BROWSER_OUTPUT: 13:11:33 INFO - 2015-11-28 13:11:33,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51265/tests/kraken/driver.html?testName=audio-oscillator) 13:11:34 INFO - 2015-11-28 13:11:34,212 DEBUG : BROWSER_OUTPUT: RSS: Main: 136306688 13:11:34 INFO - 2015-11-28 13:11:34,213 DEBUG : BROWSER_OUTPUT: 13:11:36 INFO - 2015-11-28 13:11:36,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:11:36 INFO - 2015-11-28 13:11:36,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 137089024 13:11:36 INFO - 2015-11-28 13:11:36,993 DEBUG : BROWSER_OUTPUT: 13:11:39 INFO - 2015-11-28 13:11:39,976 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51265/tests/kraken/driver.html?testName=imaging-darkroom) 13:11:40 INFO - 2015-11-28 13:11:40,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 138633216 13:11:40 INFO - 2015-11-28 13:11:40,562 DEBUG : BROWSER_OUTPUT: 13:11:43 INFO - 2015-11-28 13:11:43,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51265/tests/kraken/driver.html?testName=imaging-desaturate) 13:11:44 INFO - 2015-11-28 13:11:44,512 DEBUG : BROWSER_OUTPUT: RSS: Main: 138858496 13:11:44 INFO - 2015-11-28 13:11:44,512 DEBUG : BROWSER_OUTPUT: 13:11:47 INFO - 2015-11-28 13:11:47,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51265/tests/kraken/driver.html?testName=json-parse-financial) 13:11:47 INFO - 2015-11-28 13:11:47,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 139218944 13:11:47 INFO - 2015-11-28 13:11:47,920 DEBUG : BROWSER_OUTPUT: 13:11:49 INFO - 2015-11-28 13:11:49,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:11:50 INFO - 2015-11-28 13:11:50,062 DEBUG : BROWSER_OUTPUT: RSS: Main: 138022912 13:11:50 INFO - 2015-11-28 13:11:50,062 DEBUG : BROWSER_OUTPUT: 13:11:51 INFO - 2015-11-28 13:11:51,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:11:52 INFO - 2015-11-28 13:11:52,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 137711616 13:11:52 INFO - 2015-11-28 13:11:52,521 DEBUG : BROWSER_OUTPUT: 13:11:54 INFO - 2015-11-28 13:11:54,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:11:55 INFO - 2015-11-28 13:11:55,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 139350016 13:11:55 INFO - 2015-11-28 13:11:55,194 DEBUG : BROWSER_OUTPUT: 13:11:57 INFO - 2015-11-28 13:11:57,689 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:11:58 INFO - 2015-11-28 13:11:58,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 138334208 13:11:58 INFO - 2015-11-28 13:11:58,290 DEBUG : BROWSER_OUTPUT: 13:12:00 INFO - 2015-11-28 13:12:00,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:12:01 INFO - 2015-11-28 13:12:01,411 DEBUG : BROWSER_OUTPUT: RSS: Main: 138854400 13:12:01 INFO - 2015-11-28 13:12:01,412 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51265/tests/kraken/driver.html?testName=ai-astar) 13:12:03 INFO - 2015-11-28 13:12:03,359 DEBUG : BROWSER_OUTPUT: RSS: Main: 138235904 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;103;110;110;111;122;110;110;109;110 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;134;153;171;126;154;153;127;168;127 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;162;163;162;164;166;175;163 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;72;71;71;71;141;73;71;72 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;140;94;94;93;137;96;93;133 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;111;110;111;110;110;110;110 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;146;146;145;146;147;146 13:12:03 INFO - 2015-11-28 13:12:03,360 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;97;97;96;96;98;98;96;97;96 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;60;61;62;59;60;61;63;64;62;60 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;70;70;70;70;70;75;70;70;70 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;88;87;86;84;93;87;84;85;85 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;127;120;119;127;125;125;126;131;125 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;150;140;142;156;151;145;148;142;143 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;68;67;68;69;67;68;68;67;66 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: __start_cc_report 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,710 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: __end_cc_report 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: __startTimestamp1448745123354__endTimestamp 13:12:03 INFO - 2015-11-28 13:12:03,361 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,362 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:12:03 INFO - 2015-11-28 13:12:03,362 DEBUG : BROWSER_OUTPUT: Number of tests: 14 13:12:03 INFO - 2015-11-28 13:12:03,362 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,362 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:110.00 stddev:4.69 (4.3%) stddev-sans-first:4.90 13:12:03 INFO - 2015-11-28 13:12:03,362 DEBUG : BROWSER_OUTPUT: Values: 113.0 103.0 110.0 110.0 111.0 122.0 110.0 110.0 109.0 110.0 13:12:03 INFO - 2015-11-28 13:12:03,362 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,362 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.60 Median:153.00 stddev:16.94 (11.1%) stddev-sans-first:17.81 13:12:03 INFO - 2015-11-28 13:12:03,362 DEBUG : BROWSER_OUTPUT: Values: 153.0 134.0 153.0 171.0 126.0 154.0 153.0 127.0 168.0 127.0 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:163.00 stddev:4.11 (2.5%) stddev-sans-first:4.29 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 162.0 163.0 162.0 164.0 166.0 175.0 163.0 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.80 Median:72.00 stddev:21.88 (30.4%) stddev-sans-first:23.07 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 72.0 71.0 71.0 71.0 141.0 73.0 71.0 72.0 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:93.00 stddev:20.83 (22.4%) stddev-sans-first:21.51 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 140.0 94.0 94.0 93.0 137.0 96.0 93.0 133.0 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 13:12:03 INFO - 2015-11-28 13:12:03,363 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 111.0 110.0 111.0 110.0 110.0 110.0 110.0 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 146.0 146.0 145.0 146.0 147.0 146.0 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:0.82 (0.8%) stddev-sans-first:0.83 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: Values: 96.0 97.0 97.0 96.0 96.0 98.0 98.0 96.0 97.0 96.0 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:61.20 Median:61.50 stddev:1.55 (2.5%) stddev-sans-first:1.58 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: Values: 60.0 61.0 62.0 59.0 60.0 61.0 63.0 64.0 62.0 60.0 13:12:03 INFO - 2015-11-28 13:12:03,364 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,366 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.00 stddev:1.58 (2.3%) stddev-sans-first:1.67 13:12:03 INFO - 2015-11-28 13:12:03,366 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 70.0 70.0 70.0 70.0 75.0 70.0 70.0 70.0 13:12:03 INFO - 2015-11-28 13:12:03,366 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,366 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:2.75 (3.2%) stddev-sans-first:2.79 13:12:03 INFO - 2015-11-28 13:12:03,366 DEBUG : BROWSER_OUTPUT: Values: 84.0 88.0 87.0 86.0 84.0 93.0 87.0 84.0 85.0 85.0 13:12:03 INFO - 2015-11-28 13:12:03,366 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,366 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.70 Median:125.50 stddev:3.56 (2.8%) stddev-sans-first:3.64 13:12:03 INFO - 2015-11-28 13:12:03,366 DEBUG : BROWSER_OUTPUT: Values: 122.0 127.0 120.0 119.0 127.0 125.0 125.0 126.0 131.0 125.0 13:12:03 INFO - 2015-11-28 13:12:03,366 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,367 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.90 Median:149.00 stddev:5.28 (3.5%) stddev-sans-first:5.27 13:12:03 INFO - 2015-11-28 13:12:03,367 DEBUG : BROWSER_OUTPUT: Values: 152.0 150.0 140.0 142.0 156.0 151.0 145.0 148.0 142.0 143.0 13:12:03 INFO - 2015-11-28 13:12:03,367 DEBUG : BROWSER_OUTPUT: 13:12:03 INFO - 2015-11-28 13:12:03,367 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:68.00 stddev:0.97 (1.4%) stddev-sans-first:0.88 13:12:03 INFO - 2015-11-28 13:12:03,367 DEBUG : BROWSER_OUTPUT: Values: 66.0 68.0 67.0 68.0 69.0 67.0 68.0 68.0 67.0 66.0 13:12:03 INFO - 2015-11-28 13:12:03,367 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:12:03 INFO - 2015-11-28 13:12:03,367 DEBUG : BROWSER_OUTPUT: 13:12:04 INFO - 2015-11-28 13:12:04,410 INFO : Browser exited with error code: 0 13:12:04 INFO - 2015-11-28 13:12:04,464 INFO : Completed test kraken (00:01:00) 13:12:04 INFO - 2015-11-28 13:12:04,464 INFO : Starting test v8_7 13:12:04 INFO - 2015-11-28 13:12:04,464 DEBUG : operating with platform_type : linux_ 13:12:04 INFO - 2015-11-28 13:12:04,464 INFO : Initialising browser for v8_7 test... 13:12:04 INFO - 2015-11-28 13:12:04,470 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5OBXzX/profile http://localhost:51265/getInfo.html 13:12:09 INFO - 2015-11-28 13:12:09,202 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 13:12:09 INFO - 2015-11-28 13:12:09,203 DEBUG : BROWSER_OUTPUT: colorDepth:24 13:12:09 INFO - 2015-11-28 13:12:09,203 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 13:12:09 INFO - 2015-11-28 13:12:09,203 DEBUG : BROWSER_OUTPUT: __metrics 13:12:10 INFO - 2015-11-28 13:12:10,294 INFO : Browser initialized. 13:12:10 INFO - 2015-11-28 13:12:10,295 INFO : Running cycle 1/1 for v8_7 test... 13:12:10 INFO - 2015-11-28 13:12:10,295 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp5OBXzX/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 13:12:22 INFO - 2015-11-28 13:12:22,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 138706944 13:12:22 INFO - 2015-11-28 13:12:22,029 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51265/tests/v8_7/run.html (next: http://localhost:51265/tests/v8_7/run.html) 13:12:43 INFO - 2015-11-28 13:12:43,665 DEBUG : BROWSER_OUTPUT: RSS: Main: 137728000 13:12:43 INFO - 2015-11-28 13:12:43,666 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,666 DEBUG : BROWSER_OUTPUT: __start_tp_report 13:12:43 INFO - 2015-11-28 13:12:43,666 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 13:12:43 INFO - 2015-11-28 13:12:43,666 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 13:12:43 INFO - 2015-11-28 13:12:43,666 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 13:12:43 INFO - 2015-11-28 13:12:43,666 DEBUG : BROWSER_OUTPUT: |0;Richards;166.91704223001167 13:12:43 INFO - 2015-11-28 13:12:43,667 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.5287569573284 13:12:43 INFO - 2015-11-28 13:12:43,667 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.56388034665923 13:12:43 INFO - 2015-11-28 13:12:43,667 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5154.639175257732 13:12:43 INFO - 2015-11-28 13:12:43,667 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1042.752867570386 13:12:43 INFO - 2015-11-28 13:12:43,667 DEBUG : BROWSER_OUTPUT: |5;Earley;726.7441860465116 13:12:43 INFO - 2015-11-28 13:12:43,668 DEBUG : BROWSER_OUTPUT: |6;Boyer;12084.33734939759 13:12:43 INFO - 2015-11-28 13:12:43,668 DEBUG : BROWSER_OUTPUT: |7;RegExp;25100 13:12:43 INFO - 2015-11-28 13:12:43,668 DEBUG : BROWSER_OUTPUT: |8;Splay;569.1519635742743 13:12:43 INFO - 2015-11-28 13:12:43,668 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 13:12:43 INFO - 2015-11-28 13:12:43,668 DEBUG : BROWSER_OUTPUT: __end_tp_report 13:12:43 INFO - 2015-11-28 13:12:43,669 DEBUG : BROWSER_OUTPUT: __startTimestamp1448745163664__endTimestamp 13:12:43 INFO - 2015-11-28 13:12:43,669 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,669 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 13:12:43 INFO - 2015-11-28 13:12:43,669 DEBUG : BROWSER_OUTPUT: Number of tests: 10 13:12:43 INFO - 2015-11-28 13:12:43,669 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,669 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.92 Median:166.92 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,670 DEBUG : BROWSER_OUTPUT: Values: 166.9 13:12:43 INFO - 2015-11-28 13:12:43,670 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,670 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.53 Median:185.53 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,670 DEBUG : BROWSER_OUTPUT: Values: 185.5 13:12:43 INFO - 2015-11-28 13:12:43,670 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,670 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.56 Median:279.56 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,671 DEBUG : BROWSER_OUTPUT: Values: 279.6 13:12:43 INFO - 2015-11-28 13:12:43,671 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,671 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5154.64 Median:5154.64 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,671 DEBUG : BROWSER_OUTPUT: Values: 5154.6 13:12:43 INFO - 2015-11-28 13:12:43,671 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,673 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1042.75 Median:1042.75 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,673 DEBUG : BROWSER_OUTPUT: Values: 1042.8 13:12:43 INFO - 2015-11-28 13:12:43,673 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,673 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:726.74 Median:726.74 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,673 DEBUG : BROWSER_OUTPUT: Values: 726.7 13:12:43 INFO - 2015-11-28 13:12:43,674 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,674 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12084.34 Median:12084.34 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,674 DEBUG : BROWSER_OUTPUT: Values: 12084.3 13:12:43 INFO - 2015-11-28 13:12:43,674 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,674 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25100.00 Median:25100.00 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,675 DEBUG : BROWSER_OUTPUT: Values: 25100.0 13:12:43 INFO - 2015-11-28 13:12:43,675 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,675 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:569.15 Median:569.15 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,675 DEBUG : BROWSER_OUTPUT: Values: 569.2 13:12:43 INFO - 2015-11-28 13:12:43,675 DEBUG : BROWSER_OUTPUT: 13:12:43 INFO - 2015-11-28 13:12:43,676 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 13:12:43 INFO - 2015-11-28 13:12:43,676 DEBUG : BROWSER_OUTPUT: Values: 4835.7 13:12:43 INFO - 2015-11-28 13:12:43,676 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 13:12:43 INFO - 2015-11-28 13:12:43,676 DEBUG : BROWSER_OUTPUT: 13:12:44 INFO - 2015-11-28 13:12:44,566 INFO : Browser exited with error code: 0 13:12:44 INFO - 2015-11-28 13:12:44,581 INFO : Completed test v8_7 (00:00:40) 13:12:44 INFO - 2015-11-28 13:12:44,710 INFO : Completed test suite (00:20:11) 13:12:44 INFO - 2015-11-28 13:12:44,710 DEBUG : Working with test: dromaeo_css 13:12:44 INFO - 2015-11-28 13:12:44,710 DEBUG : Generating results file: dromaeo_css 13:12:44 INFO - 2015-11-28 13:12:44,711 DEBUG : Working with test: kraken 13:12:44 INFO - 2015-11-28 13:12:44,711 DEBUG : Generating results file: kraken 13:12:44 INFO - 2015-11-28 13:12:44,712 INFO : javascript benchmark 13:12:44 INFO - 2015-11-28 13:12:44,712 DEBUG : Working with test: v8_7 13:12:44 INFO - 2015-11-28 13:12:44,712 DEBUG : Generating results file: v8_7 13:12:44 INFO - 2015-11-28 13:12:44,712 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:44 INFO - 2015-11-28 13:12:44,764 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,43]] 13:12:44 INFO - 2015-11-28 13:12:44,764 DEBUG : process_Request line: dromaeo_css 7166.30 graph.html#tests=[[72,64,43]] 13:12:44 INFO - 2015-11-28 13:12:44,764 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:44 INFO - 2015-11-28 13:12:44,884 DEBUG : process_Request line: kraken 1516.90 graph.html#tests=[[232,64,43]] 13:12:44 INFO - 2015-11-28 13:12:44,884 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 13:12:44 INFO - 2015-11-28 13:12:44,991 DEBUG : process_Request line: v8_7 21595.73 graph.html#tests=[[230,64,43]] 13:12:44 INFO - 2015-11-28 13:12:44,992 INFO : javascript benchmark 13:12:45 INFO - 2015-11-28 13:12:44,996 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3189.1708155879473, 3262.8857989970343, 3280.4751239801635, 3297.818619975901, 3314.2542927841237, 5434.673919564819, 5548.500634942854, 5552.528035117015, 5577.358603760569, 5582.023145949458, 5479.99999999999, 5516.200150978106, 5524.502794748471, 5594.9089927464165, 5604.243427137335, 5000.874978125548, 5084.3136176616235, 5180.922286165692, 5198.116320225552, 5202.06362854686, 5017.949820501784, 5089.185730283156, 5156.510131537498, 5173.663711858717, 5212.6611770235, 4951.8514444566545, 4996.625253106032, 5059.0, 5061.620378471593, 5088.847334579968, 5052.595792336604, 5063.443021267658, 5064.5441910228255, 5067.746612669389, 5113.846584602468, 5009.4239162496415, 5011.599072074226, 5014.2979982802435, 5035.723035233061, 5043.470435604282, 5212.374515058179, 5257.263983042377, 5272.103742363807, 5286.524212820865, 5358.4641535846495, 6005.849853753647, 6039.516838652941, 6043.879122417571, 6048.758049678007, 6050.122732203849, 6061.393860613947, 6069.211002569682, 6079.331273559905, 6092.51259899207, 6093.817185484442, 5413.458654134594, 5505.944940550623, 5514.862128446781, 5570.498655120978, 5654.010548154098, 6074.088886667036, 6077.574569780073, 6085.939140608626, 6090.390960903874, 6107.267127944675, 5762.394948530344, 5865.706714664249, 5906.793262235801, 5916.319623243296, 5937.851553711192, 5856.1508581255475, 5928.614640048383, 6023.909641355383, 6024.939750602438, 6083.391660833881, 5679.460451257124, 5695.8860822784145, 5712.714364281769, 5717.971410142923, 5730.426957304237, 5817.912731309034, 5820.563457740686, 5830.941690583125, 5833.270841144857, 5962.731677074542, 4517.728936263835, 4567.109413664303, 4574.839880604163, 4576.679632425698, 4613.953860461353, 4086.1214838809206, 4106.548279689232, 4110.362893751473, 4113.0, 4141.0, 5556.055470570012, 5595.720213989284, 5618.325800903836, 5753.395893431213, 5767.769289228468, 6054.697265136726, 6057.091436284592, 6060.666663333471, 6065.696715164224, 6101.725422356005, 5735.942640573541, 5740.626859254218, 5744.913826292609, 5757.0788673811985, 5762.654240745569, 5069.695818250917, 5075.492450754895, 5101.795928162832, 5225.92161117576, 5239.921401178985, 5992.970035149883, 6177.752889884354, 6208.844778880474, 6231.844203894939, 6246.000639897686, 6017.548683848817, 6020.518358531394, 6054.212952316171, 6063.272407311151, 6078.3921607838865, 6013.188219590475, 6022.337542870193, 6100.664463454553, 6119.0, 6142.662153581417, 5899.67551784656, 5904.380040095728, 5931.555133365101, 5984.850378740566, 5986.970065149821, 5808.94191058084, 6045.365236650265, 6057.636541807506, 6062.363451837494, 6076.240469941257, 5832.445917637818, 5849.181114644039, 5904.350521442724, 5919.526437884872, 5973.402659733992, 5691.26013618227, 5694.202811606461, 5697.173909782975, 5706.743196556248, 5715.9142612860005, 5578.888422231614, 5617.325920889356, 5622.32532096151, 5685.60200785941, 5787.189793428839, 5755.510781583613, 5811.157382179645, 5865.648061116347, 5874.295084589877, 5874.911876321773, 5625.521830644441, 5660.943390566042, 5666.9716651416475, 5686.943130568807, 5688.601797874109], "unit": "ms", "name": "dojo.html", "value": 5488.490666516114}, {"lowerIsBetter": false, "replicates": [554.4344768336294, 596.0701305962696, 598.7096258314716, 601.765311528504, 607.9817605471836, 30868.845655771718, 40689.79655101724, 41117.794411027906, 41475.58524414759, 41630.37554436678, 42913.141737165315, 43366.56633433665, 43412.0, 43437.56562434375, 43735.562644373545, 8997.550122493865, 9158.221551168159, 9176.724698259062, 9188.540572971324, 9209.079092090804, 8795.648174073029, 8810.38327317088, 8852.645894164225, 8877.778055548599, 8877.95561022194, 8868.201861832435, 8966.596503157341, 8978.191962723353, 8983.146601072887, 8987.685431009915, 8890.110988901122, 8958.148975847284, 8983.505907175102, 8985.0, 8996.685116020908, 8755.649774009033, 8883.067277935788, 8905.243054340324, 8965.596548155349, 8968.820623587491, 40591.39112913309, 40899.182016359504, 40925.18149636991, 41221.0, 41246.58753412458, 3404.9489257661153, 3490.3542844573835, 3540.539729835105, 3679.797611131387, 3933.115049113955, 30146.0956171313, 30489.847550762104, 30688.38623227523, 30743.0, 30821.229469263224, 3395.3548825723033, 3415.52182694423, 3481.1993241554333, 3547.18414764603, 3616.3129005488872, 293430.0, 295333.0, 295456.0, 295593.0, 295957.0, 58602.0, 59539.0, 62788.37211627825, 67228.0, 67397.66301168462, 64673.67663161654, 64918.675406622664, 64998.67500662561, 65254.67372663201, 65268.67365663236, 15791.684166316609, 15846.841531584536, 15937.601559961095, 15955.840441595668, 15978.0, 12367.69080772988, 12522.812157817458, 12581.93709031449, 12583.937080314723, 12627.43176557057, 21100.683489747666, 21265.36203913854, 21281.148754049664, 21331.78668213329, 21388.679169812465, 8141.0, 8422.747317580483, 8476.618552165044, 8495.95752021236, 8620.568971551398, 1037.5642230263309, 1054.0671505717496, 1070.7269646240159, 1160.6053941659877, 1182.846229990113, 33435.66564334326, 34153.0, 34168.0, 34336.82831585826, 34441.31117377638, 1036.3419228789621, 1050.4275170032352, 1054.4727636181908, 1083.8428427877914, 1147.4320211495362, 14810.777838332433, 16978.830211697725, 17114.0, 17366.0, 17386.565335866453, 442233.0, 442245.0, 445444.0, 445819.0, 446280.0, 56165.71917140388, 56305.71847140738, 56524.15213771797, 56644.15033774497, 56892.43107568871, 1351.2568087551808, 1381.3852835488312, 1384.0657556149558, 1394.3864699532173, 1399.4612074351448, 29081.272968175967, 30401.695983040772, 31905.0, 32545.674543254263, 33180.66819331872, 52122.0, 53065.469345307596, 53133.20300195423, 53263.733681331345, 53322.73338633282, 308471.0, 311802.0, 312035.0, 312378.0, 312572.0, 42553.787231063645, 46739.0, 47123.29315060345, 47456.288155677, 47865.76067119642, 45074.098518030114, 45187.54812451833, 45436.54563454323, 45981.0, 46045.53954460412, 37818.0, 38007.42988855114, 38946.6105338943, 39012.80493597514, 39227.01932451712, 37360.25279494449, 38381.61618383892, 38684.6131538681, 41507.792461037505, 42455.0, 38816.0, 40202.59797401988, 40894.591054089076, 40901.1819763609, 41031.0, 30268.84865575746, 31749.206269842514, 34452.48321275233, 35677.0, 38696.226075478895, 26120.608190876774, 26448.8677556611, 26575.0, 26685.733142668323, 26843.328916776456], "unit": "ms", "name": "ext.html", "value": 19899.590472308828}, {"lowerIsBetter": false, "replicates": [353.4592074126587, 358.3907357492262, 358.4909428611372, 360.15004589169564, 360.16441854896635, 16420.753688694665, 16615.584610384747, 17388.91305543472, 17394.739078913826, 18038.5490362741, 10749.785004299909, 11630.651080467578, 15965.441209557639, 15981.360745570164, 16015.0, 4691.953080469203, 4894.583960363373, 4904.773806548363, 4915.606751459874, 4921.212605983043, 4836.226203807391, 4867.659263851532, 4907.975460122712, 4908.779104940286, 4910.386201724785, 4927.113119638464, 4945.604351651859, 5096.694198348111, 5235.057689615867, 5269.209618557228, 5208.817691380802, 5229.1633338666015, 5233.869153271161, 5239.607029472805, 5260.473952604728, 5057.595392368602, 5282.788688452457, 5290.470952904679, 5291.788328466857, 5322.946770532284, 19330.0, 19400.902995484932, 19509.414717558495, 19795.703064454046, 19899.403017909484, 2105.26315789474, 2182.7380714314386, 2189.0074188532053, 2192.7478339990944, 2197.8901054947187, 9273.489958052372, 9300.581473833694, 9355.578998944995, 9544.42733435996, 9699.951500242525, 1776.5736223306442, 1848.3161230344858, 1881.7177423386465, 1886.528367908023, 1891.6122194950003, 60017.399826001616, 62076.37923620796, 62631.686841565956, 63365.68317158385, 64297.35702642961, 9463.391223492023, 9814.362066465657, 10119.747006324753, 10136.493175341204, 10180.440075795903, 13173.736525269633, 13210.537631183055, 13223.0, 13258.204507729568, 13284.136531125447, 7524.360429363456, 7645.235476452311, 7697.268759467842, 7774.611269436618, 7828.647710853025, 7625.389968802482, 7659.234076592296, 7663.6168191590195, 7701.614919254015, 7714.807129821799, 4304.698671092993, 4349.434573505424, 4350.651947844165, 4366.388705581221, 4397.878540972096, 1733.8352856478614, 1735.6788994036144, 1760.4630587670883, 1772.3265159239406, 1774.0774797105432, 414.6889832625531, 425.15818679015723, 430.8922769307673, 450.8129126412568, 941.289326558444, 14855.331510082073, 16445.342186312653, 17507.38724144649, 17857.732134018, 18134.81865181331, 919.6091661044029, 937.5218638494281, 939.196986576481, 950.4297421547017, 963.3689933093834, 9723.367981081206, 9887.505624718735, 9916.454594997344, 9924.751881203028, 9946.35348702332, 599557.0, 599618.0, 601814.0, 624221.9411350086, 626767.5909168196, 84298.0, 85063.14936850552, 85228.57385713156, 85482.57258713791, 86045.56977215073, 1171.29722166701, 1180.9232399894152, 1182.408795602199, 1184.5498710489958, 1186.1756079524648, 15452.84547154559, 15485.148316842682, 15497.225138743242, 15738.685226295638, 15874.285657145687, 32200.0, 33723.83138084392, 34120.829395853856, 34753.30493390169, 35837.0, 41039.17921641491, 41340.0, 41667.58332416637, 42538.0, 43582.56417435785, 8960.372773906025, 9048.773780655536, 9243.445393276425, 9351.39215950961, 9359.344845860724, 12622.495100195889, 16692.332306707594, 16873.493795186165, 17217.655646887244, 17298.394556190473, 14100.0, 14641.926790366406, 14771.852281477477, 14856.257187140816, 15117.773233401287, 13607.115537490032, 13892.16647001183, 14002.299885005505, 14174.503892363718, 14177.291135443393, 14240.430382784987, 14284.500042498463, 14698.41206351734, 14884.330205140577, 15223.543293701206, 9492.382995105296, 9655.662051828152, 9749.512524373895, 9797.363171393836, 9823.508824558887, 9968.700938971842, 10066.396016239049, 14080.0, 14240.786388203978, 14883.25583720788], "unit": "ms", "name": "jquery.html", "value": 8635.455545277999}, {"lowerIsBetter": false, "replicates": [1509.433962264151, 1677.4883660483556, 1748.4317596781045, 1751.696519077413, 1778.546470649984, 7273.16358618759, 7330.633468326589, 7669.309762121408, 7696.114946781122, 7727.0, 7657.081150261963, 7674.0, 7718.151003389623, 7742.574158421298, 7766.0, 2276.4195130241806, 2287.553926984239, 2296.5866144094057, 2300.67790509328, 2312.6762253284555, 2231.0, 2262.2534563593977, 2269.6822444857735, 2270.8069814065743, 2273.874936878471, 2245.6856040154394, 2252.414372263207, 2272.6704627828954, 2280.384296240014, 2300.9884950575306, 2177.412098733333, 2243.2372993182316, 2249.2352600115873, 2258.1870526610405, 2271.4094335472732, 2302.481941563152, 2323.7211534615953, 2324.4653729642278, 2325.3372788755123, 2330.9300720978226, 7398.519096258726, 7468.514546554511, 7498.775036748906, 7503.5497870127965, 7503.587302698349, 4481.215787237253, 4567.246404343279, 4583.885402864922, 4592.15045216636, 4595.195840727859, 2987.9402411951855, 3014.9397012059635, 3095.876164953399, 3098.380323935222, 3136.9843150784327, 1040.380973320873, 1043.7390652336917, 1750.9037002964833, 1784.5003399048157, 1785.5357607022138, 9920.900790992142, 10036.046575575381, 10046.69859904204, 10083.294169408144, 10157.54291056897, 4044.2113787811095, 4063.187362527506, 4104.0, 4109.856155034559, 4129.814158362881, 8206.712765053315, 8221.917780822236, 8244.752657420288, 8269.95865020671, 8276.917230827736, 4484.506704262529, 4536.432945881765, 4563.794629241692, 4576.81692732287, 4594.839180628662, 4160.563140870226, 4224.8732538023905, 4233.0, 4257.212415703105, 4257.936130958038, 3375.223698549298, 3381.814000229962, 3383.052745231339, 3394.5587073680263, 3400.4219282721997, 1057.4025675493322, 1069.0, 1074.4520294649628, 1079.6275285026654, 1082.967510974672, 1012.3824467075078, 1060.9814578005048, 1072.7425417899804, 1130.383940752292, 1301.3038024656764, 7021.052157958712, 7045.189803172599, 7077.858442831114, 7089.82275443118, 7092.397146242524, 594.5689375202943, 756.3117563017628, 1205.4695933789105, 1231.2858542045772, 1244.2037096258402, 5641.576881733804, 5676.8864622707315, 5685.943140568541, 5708.571857110734, 5727.284089488814, 8672.132786721277, 8706.390552661253, 8792.296616270683, 8813.955930220436, 8934.0, 8601.870971935426, 8627.396082274181, 8637.740867773977, 8719.825603488021, 8747.956260218785, 7035.683394247271, 7049.894251586128, 7080.327368899946, 7158.391536719437, 7204.891926621, 7137.10786151731, 7148.678309475982, 7154.785356439315, 7166.0, 7186.568805871664, 7925.564093974886, 7981.241782030698, 8009.399295053011, 8135.0, 8158.510489370657, 8109.351251899716, 8153.959230203811, 8212.13772553897, 8220.83558328818, 8249.133840946613, 6543.70553325111, 6564.540482166202, 6804.21751498584, 6826.385625293748, 6835.282295358916, 7306.488545801955, 7308.744193953186, 7317.67070481819, 7335.816604584928, 7349.77950661481, 6726.0, 6778.3221677831825, 6959.19969203548, 6978.47661425385, 7033.753818616324, 6601.834954126185, 6727.596344219362, 6762.966185169043, 6771.796846094625, 6780.084688566981, 6673.532852700265, 6708.798736037927, 6710.765123220664, 6711.295313991961, 6724.831879203059, 5927.0, 6050.485708714808, 6060.393960603904, 6064.787732429344, 6267.310595834363, 6283.937160628335, 6300.495960323072, 6326.841828954129, 6330.683465826783, 6341.0], "unit": "ms", "name": "mootools.html", "value": 4403.187755507272}, {"lowerIsBetter": false, "replicates": [334.8995301409577, 338.3875185913497, 339.06418285531953, 344.60542678632976, 350.40256362901255, 6275.8117256482265, 6306.085617585447, 6333.968330158348, 6409.038644203371, 6512.251091124522, 6293.874122517547, 6333.398327158924, 6336.0, 6342.936570634292, 6346.397092276238, 4746.620270378378, 4779.976100119512, 4786.52134786522, 4794.87320479687, 4800.303955926389, 4784.688995215317, 4790.113828941657, 4794.544518270776, 4801.8079276828885, 4809.254565542329, 4622.791974361145, 4731.053789242148, 4736.2895565665085, 4737.0, 4742.739149346785, 4713.92929106062, 4725.3148293497425, 4728.172569800271, 4746.382970213867, 4753.786079626425, 4078.1028173801715, 4084.9387259191135, 4085.0, 4090.3864420337186, 4099.97950010251, 5948.345681974979, 5973.6415815050805, 5983.910241346383, 6005.159277701126, 6014.669193194372, 5357.946420535784, 5482.424345443751, 5509.724513774296, 5535.972320138373, 5554.305711786027, 6719.496037797136, 6726.12560367154, 6727.932720672779, 6731.730730770763, 6731.831704207385, 4508.5266047064915, 4510.797014134372, 4515.63874890008, 4519.502854685982, 4521.208788462006, 6773.45812335012, 6923.792286231421, 6945.965270173668, 6947.826304342381, 6983.895241571431, 4652.930206046912, 4671.719696818202, 4672.369230153886, 4675.275332323496, 4680.3915490985955, 4731.361266229083, 4733.100710864925, 4737.028909073701, 4738.099761045391, 4742.952570474251, 5495.450454954553, 5507.449255074541, 5511.283533140666, 5514.503694667499, 5518.172274158908, 6601.70292336846, 6690.264070952191, 6705.798826035227, 6724.260331363546, 6742.9662851685425, 1631.9428819991244, 1663.434432293002, 1665.192381694877, 1679.9748003779953, 1681.0334057916746, 1096.4682129167347, 1096.5942601237593, 1111.6831702964616, 1116.1015382616908, 1121.7532142928542, 6398.8080357588415, 6463.741450342028, 6468.320826313169, 6482.351764823574, 6483.384078512534, 6836.145481814773, 6852.760153394607, 6860.897086543706, 6898.965505172442, 6902.102726645504, 6313.210848643919, 6417.96791016042, 6424.068510066014, 6450.322716114741, 6457.451116655043, 3766.114962983697, 3801.3727734923427, 3816.160444702161, 3818.4463252828186, 3825.1202223488754, 7244.0, 7273.89089163663, 7281.635918204069, 7287.890681639779, 7308.37878780299, 6942.271061538567, 7151.392131668762, 7186.964065179641, 7196.424286057103, 7206.243344448862, 7234.819129521804, 7257.818554536285, 7260.382867456326, 7279.1265048194555, 7285.672144753499, 7003.26465721092, 7004.894926576208, 7007.299270072952, 7009.334113259232, 7021.754238601625, 6719.26088130315, 6851.663925534473, 6872.587644741331, 6888.483363747639, 6903.93096069053, 7265.600391978492, 7272.854542909006, 7280.453965952469, 7282.854342913006, 7296.452766042462, 4631.980964187874, 4667.089917466062, 4667.113248482778, 4672.719636821802, 4673.929891051569, 6806.523543351917, 6844.076049733222, 6928.688209030505, 6974.721011159497, 6981.197162326397, 6779.35596118368, 6804.6257455840405, 6804.727810887509, 6820.931790682228, 6839.247682754993, 6706.597604143767, 6742.69657865407, 6753.264927704287, 6766.86466270662, 6778.694958726771, 6512.967435162794, 6646.83382915431, 6660.933390666031, 6664.5668031579735, 6690.899636505554, 6805.217399999064, 6834.931650683429, 6847.281035491202, 6852.143482064742, 6852.657367131723, 6626.105475760904, 6661.267260601233, 6682.866342673216, 6687.364700353459, 6688.83277918056], "unit": "ms", "name": "prototype.html", "value": 5038.463733120516}, {"lowerIsBetter": false, "replicates": [769.6036541181293, 809.4050872608632, 809.6194788449428, 839.9664013439462, 876.7764220123868, 13682.657933551665, 13711.725765484684, 13901.374438150282, 13924.791128133085, 13959.860401395996, 13415.0, 13461.1923284603, 13482.93258533706, 13540.661483462918, 13564.389602467889, 830.8296799156174, 840.6175190288404, 849.9150084991513, 851.6508231625035, 853.5646820121751, 835.1147783349638, 843.3548335523299, 854.2994744309668, 855.1234984141242, 856.6701819799359, 885.2961895293257, 895.8253140637578, 900.275278400887, 901.5492253873064, 902.0303174087849, 881.0704706534603, 885.4642941020686, 890.6838072484304, 892.4243862708549, 893.1693525021727, 652.6801867085142, 655.4625207329991, 658.6344578758788, 659.2056571830932, 660.1780782925241, 13058.934705326508, 13092.934535327262, 13110.0, 13208.933955330258, 13215.273159976197, 12108.57619983305, 12563.434645440886, 12765.93617031909, 12871.0, 12903.806442903364, 10262.794744105151, 10340.482975851253, 10379.896201038044, 10810.72973175669, 10917.39954302513, 3589.766665166756, 3649.59854416014, 3687.225682606629, 3688.4467329900463, 3762.0, 48740.26889596659, 49613.50386496125, 49632.50367496315, 49697.0, 49766.7511662443, 10068.231236410045, 10091.293609447415, 10200.28597998133, 10360.0, 10435.634752783617, 17491.737623935398, 17599.560010999572, 17605.471835844946, 17653.205605747517, 17676.558086047695, 7606.467547271638, 7706.807329816687, 7754.651040703182, 7757.301842834172, 7763.72826951054, 4146.91706165881, 4182.853600123981, 4199.139176468817, 4227.492700875853, 4257.212415703105, 3109.7978631388887, 3151.7636177286795, 3156.71589556941, 3178.936421271562, 3182.124915648169, 551.8013515134548, 566.3260719743492, 567.7274908044079, 571.5313442976802, 574.4427904932209, 652.8367908022994, 685.4550632247375, 691.5574032619128, 696.4428457234294, 707.3916431868589, 7769.922300777033, 8025.0, 8472.0, 8616.353773467015, 8631.956840215758, 566.5326105962597, 571.9571032172604, 700.3906601256838, 718.0542916672812, 733.4719002318429, 3900.90247743803, 4208.410822484854, 4227.619514243671, 4239.915201695949, 4276.893077673083, 54989.0, 55646.443535564125, 55912.44087559072, 56151.0, 57490.13764793531, 49394.259086113736, 49955.0, 51136.0, 52244.738776306636, 54931.176032359544, 51957.96084078373, 52210.0, 52562.211566826525, 53064.73467632637, 53213.20180197222, 8301.418900676894, 8586.184312490303, 8631.95684021601, 8916.33127515426, 9431.104045115702, 33980.49029264612, 34871.47692784559, 35468.645313546534, 35475.82262088673, 35878.820605896806, 44559.55440445684, 45502.77248613736, 45738.54261457476, 45806.31290530578, 46196.0, 11450.770984580427, 11731.589394371498, 11765.294082354743, 12035.75928481408, 12190.939045304716, 12102.75794484123, 12227.938860305641, 12340.629781106582, 12858.42137103814, 13344.599662010156, 11202.0, 11502.252353596989, 11542.59600913964, 11862.578647758053, 12280.508779649072, 11504.714640198512, 11559.942200288944, 11963.162578619413, 12361.752764944831, 12368.814467782811, 10659.520321585702, 11326.886731132583, 11349.54601815918, 11640.0, 12176.269423834598, 10208.183345332207, 10264.589416423558, 10294.168652730457, 10445.9477702611, 10852.077573406033, 9221.677241296522, 9873.0, 10024.649137280161, 10114.533392657877, 10284.537195826355], "unit": "ms", "name": "yui.html", "value": 6472.654549044927}], "name": "dromaeo_css", "value": 7166.299249972285}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 103.0, 110.0, 110.0, 111.0, 122.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [153.0, 134.0, 153.0, 171.0, 126.0, 154.0, 153.0, 127.0, 168.0, 127.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.6}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 162.0, 163.0, 162.0, 164.0, 166.0, 175.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 72.0, 71.0, 71.0, 71.0, 141.0, 73.0, 71.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.8}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 140.0, 94.0, 94.0, 93.0, 137.0, 96.0, 93.0, 133.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 111.0, 110.0, 111.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 146.0, 146.0, 145.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 98.0, 98.0, 96.0, 97.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.7}, {"lowerIsBetter": true, "replicates": [60.0, 61.0, 62.0, 59.0, 60.0, 61.0, 63.0, 64.0, 62.0, 60.0], "unit": "ms", "name": "json-parse-financial", "value": 61.2}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 70.0, 70.0, 70.0, 70.0, 75.0, 70.0, 70.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 70.5}, {"lowerIsBetter": true, "replicates": [84.0, 88.0, 87.0, 86.0, 84.0, 93.0, 87.0, 84.0, 85.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.3}, {"lowerIsBetter": true, "replicates": [122.0, 127.0, 120.0, 119.0, 127.0, 125.0, 125.0, 126.0, 131.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.7}, {"lowerIsBetter": true, "replicates": [152.0, 150.0, 140.0, 142.0, 156.0, 151.0, 145.0, 148.0, 142.0, 143.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.9}, {"lowerIsBetter": true, "replicates": [66.0, 68.0, 67.0, 68.0, 69.0, 67.0, 68.0, 68.0, 67.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 67.4}], "name": "kraken", "value": 1516.9000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.91704223001167], "unit": "score", "name": "Richards", "value": 211.49428200000003}, {"lowerIsBetter": false, "replicates": [185.5287569573284], "unit": "score", "name": "DeltaBlue", "value": 356.3760199999999}, {"lowerIsBetter": false, "replicates": [279.56388034665923], "unit": "score", "name": "Encrypt", "value": 952.1294369999999}, {"lowerIsBetter": false, "replicates": [5154.639175257732], "unit": "score", "name": "Decrypt", "value": 51.63911399999997}, {"lowerIsBetter": false, "replicates": [1042.752867570386], "unit": "score", "name": "RayTrace", "value": 709.6494509999998}, {"lowerIsBetter": false, "replicates": [726.7441860465116], "unit": "score", "name": "Earley", "value": 917.0530880000003}, {"lowerIsBetter": false, "replicates": [12084.33734939759], "unit": "score", "name": "Boyer", "value": 55.150976071784655}, {"lowerIsBetter": false, "replicates": [25100.0], "unit": "score", "name": "RegExp", "value": 36.294223107569735}, {"lowerIsBetter": false, "replicates": [569.1519635742743], "unit": "score", "name": "Splay", "value": 143.17968699999997}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21595.728323635045}]} 13:12:45 INFO - RETURN: dromaeo_css: 7166.30 13:12:45 INFO - RETURN: kraken: 1516.90 13:12:45 INFO - RETURN: v8_7: 21595.73 13:12:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,43]]", "result": "21595.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,43]]", "result": "1516.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,43]]", "result": "7166.30"}}} 13:12:45 INFO - Return code: 0 13:12:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 13:12:45 INFO - # TBPL SUCCESS # 13:12:45 INFO - Running post-action listener: _resource_record_post_action 13:12:45 INFO - Running post-run listener: _resource_record_post_run 13:12:46 INFO - Total resource usage - Wall time: 1227s; CPU: 13.0%; Read bytes: 0; Write bytes: 513478656; Read time: 0; Write time: 427668 13:12:46 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 236359680; Read time: 0; Write time: 295844 13:12:46 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 0; Write bytes: 276299776; Read time: 0; Write time: 131788 13:12:46 INFO - Running post-run listener: _upload_blobber_files 13:12:46 INFO - Blob upload gear active. 13:12:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 13:12:46 INFO - Copying logs to upload dir... 13:12:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.446906 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-11-28 13:12:44.970775) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-28 13:12:44.974759) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010094 build_url: 'https://queue.taskcluster.net/v1/task/LKPjlNgBTgOQdybJyPVnkQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-28 13:12:44.997798) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 13:12:44.998147) ========= 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=6ef107882637bc5fc02d78b7000001c2-1448719835.241024-1031485838 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-28 13:12:45.048616) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-28 13:12:45.048966) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-28 13:12:45.049339) ========= ========= Total master_lag: 0.26 =========