builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-028 starttime: 1456778113.37 results: success (0) buildid: 20160229100424 builduid: a927563885f84af483f093706e0bb134 revision: bd8994cd01487cf2e8c11d98c62178ae17904841 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.374786) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.375358) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.375650) ========= 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=836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006242 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.397881) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.398174) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.411613) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.411965) ========= 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=836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004622 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.460949) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.461256) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.461609) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.461879) ========= 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=836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-29 12:35:14-- 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% 204M=0s 2016-02-29 12:35:14 (204 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.163316 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.637493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.637802) ========= 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=836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022617 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.687205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:13.687565) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bd8994cd01487cf2e8c11d98c62178ae17904841 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev bd8994cd01487cf2e8c11d98c62178ae17904841 --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=836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-29 12:35:14,955 truncating revision to first 12 chars 2016-02-29 12:35:14,955 Setting DEBUG logging. 2016-02-29 12:35:14,956 attempt 1/10 2016-02-29 12:35:14,956 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/bd8994cd0148?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-29 12:35:15,248 unpacking tar archive at: mozilla-beta-bd8994cd0148/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631034 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:14.331106) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:14.331478) ========= echo bd8994cd01487cf2e8c11d98c62178ae17904841 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'bd8994cd01487cf2e8c11d98c62178ae17904841'] 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=836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False bd8994cd01487cf2e8c11d98c62178ae17904841 program finished with exit code 0 elapsedTime=0.003712 script_repo_revision: 'bd8994cd01487cf2e8c11d98c62178ae17904841' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:14.380038) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:14.380368) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-29 12:35:14.390856) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2016-02-29 12:35:14.391286) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:35:15 INFO - MultiFileLogger online at 20160229 12:35:15 in /builds/slave/test-pgo 12:35:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:35:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 12:35:15 INFO - {'append_to_log': False, 12:35:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 12:35:15 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:35:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 12:35:15 INFO - 'branch': 'Mozilla-Beta', 12:35:15 INFO - 'buildbot_json_path': 'buildprops.json', 12:35:15 INFO - 'config_files': ('talos/linux_config.py',), 12:35:15 INFO - 'default_actions': ('clobber', 12:35:15 INFO - 'read-buildbot-config', 12:35:15 INFO - 'download-and-extract', 12:35:15 INFO - 'populate-webroot', 12:35:15 INFO - 'create-virtualenv', 12:35:15 INFO - 'install', 12:35:15 INFO - 'run-tests'), 12:35:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:35:15 INFO - 'download_minidump_stackwalk': True, 12:35:15 INFO - 'download_symbols': 'ondemand', 12:35:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:35:15 INFO - 'tooltool.py': '/tools/tooltool.py', 12:35:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:35:15 INFO - '/tools/misc-python/virtualenv.py')}, 12:35:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:35:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:35:15 INFO - 'installer_path': 'installer.exe', 12:35:15 INFO - 'log_level': 'info', 12:35:15 INFO - 'log_name': 'talos', 12:35:15 INFO - 'log_to_console': True, 12:35:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:35:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:35:15 INFO - 'opt_config_files': (), 12:35:15 INFO - 'pip_index': False, 12:35:15 INFO - 'sps_profile': False, 12:35:15 INFO - 'sps_profile_interval': 0, 12:35:15 INFO - 'suite': 'dromaeojs', 12:35:15 INFO - 'system_bits': '32', 12:35:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:35:15 INFO - 'title': 'talos-linux64-ix-028', 12:35:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:35:15 INFO - 'use_talos_json': True, 12:35:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 12:35:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:35:15 INFO - 'work_dir': 'build'} 12:35:15 INFO - ##### 12:35:15 INFO - ##### Running clobber step. 12:35:15 INFO - ##### 12:35:15 INFO - Running pre-action listener: _resource_record_pre_action 12:35:15 INFO - Running main action method: clobber 12:35:15 INFO - rmtree: /builds/slave/test-pgo/build 12:35:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 12:35:16 INFO - Running post-action listener: _resource_record_post_action 12:35:16 INFO - ##### 12:35:16 INFO - ##### Running read-buildbot-config step. 12:35:16 INFO - ##### 12:35:16 INFO - Running pre-action listener: _resource_record_pre_action 12:35:16 INFO - Running main action method: read_buildbot_config 12:35:16 INFO - Using buildbot properties: 12:35:16 INFO - { 12:35:16 INFO - "properties": { 12:35:16 INFO - "buildnumber": 105, 12:35:16 INFO - "product": "firefox", 12:35:16 INFO - "script_repo_revision": "production", 12:35:16 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 12:35:16 INFO - "repository": "", 12:35:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 12:35:16 INFO - "buildid": "20160229100424", 12:35:16 INFO - "slavename": "talos-linux64-ix-028", 12:35:16 INFO - "pgo_build": "True", 12:35:16 INFO - "basedir": "/builds/slave/test-pgo", 12:35:16 INFO - "project": "", 12:35:16 INFO - "platform": "ubuntu64_hw", 12:35:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 12:35:16 INFO - "slavebuilddir": "test", 12:35:16 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 12:35:16 INFO - "branch": "mozilla-beta", 12:35:16 INFO - "repo_path": "releases/mozilla-beta", 12:35:16 INFO - "stage_platform": "linux64-pgo", 12:35:16 INFO - "builduid": "a927563885f84af483f093706e0bb134", 12:35:16 INFO - "revision": "bd8994cd01487cf2e8c11d98c62178ae17904841" 12:35:16 INFO - }, 12:35:16 INFO - "sourcestamp": { 12:35:16 INFO - "repository": "", 12:35:16 INFO - "hasPatch": false, 12:35:16 INFO - "project": "", 12:35:16 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 12:35:16 INFO - "changes": [ 12:35:16 INFO - { 12:35:16 INFO - "category": null, 12:35:16 INFO - "files": [ 12:35:16 INFO - { 12:35:16 INFO - "url": null, 12:35:16 INFO - "name": "https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2" 12:35:16 INFO - } 12:35:16 INFO - ], 12:35:16 INFO - "repository": "", 12:35:16 INFO - "rev": "bd8994cd01487cf2e8c11d98c62178ae17904841", 12:35:16 INFO - "who": "jkew@mozilla.com", 12:35:16 INFO - "when": 1456778002, 12:35:16 INFO - "number": 7671005, 12:35:16 INFO - "comments": "Bug 1248876 - Update graphite2 to upstream release 1.3.6. r=jrmuizel a=sledru", 12:35:16 INFO - "project": "", 12:35:16 INFO - "at": "Mon 29 Feb 2016 12:33:22", 12:35:16 INFO - "branch": "mozilla-beta-linux64-pgo-talos", 12:35:16 INFO - "revlink": "", 12:35:16 INFO - "properties": [ 12:35:16 INFO - [ 12:35:16 INFO - "buildid", 12:35:16 INFO - "20160229100424", 12:35:16 INFO - "Change" 12:35:16 INFO - ], 12:35:16 INFO - [ 12:35:16 INFO - "builduid", 12:35:16 INFO - "a927563885f84af483f093706e0bb134", 12:35:16 INFO - "Change" 12:35:16 INFO - ], 12:35:16 INFO - [ 12:35:16 INFO - "pgo_build", 12:35:16 INFO - "True", 12:35:16 INFO - "Change" 12:35:16 INFO - ] 12:35:16 INFO - ], 12:35:16 INFO - "revision": "bd8994cd01487cf2e8c11d98c62178ae17904841" 12:35:16 INFO - } 12:35:16 INFO - ], 12:35:16 INFO - "revision": "bd8994cd01487cf2e8c11d98c62178ae17904841" 12:35:16 INFO - } 12:35:16 INFO - } 12:35:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2. 12:35:16 INFO - Running post-action listener: _resource_record_post_action 12:35:16 INFO - ##### 12:35:16 INFO - ##### Running download-and-extract step. 12:35:16 INFO - ##### 12:35:16 INFO - Running pre-action listener: _resource_record_pre_action 12:35:16 INFO - Running main action method: download_and_extract 12:35:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 12:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:16 INFO - https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:35:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/test_packages.json 12:35:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/test_packages.json 12:35:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 12:35:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 12:35:17 INFO - Downloaded 1270 bytes. 12:35:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 12:35:17 INFO - Using the following test package requirements: 12:35:17 INFO - {u'common': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 12:35:17 INFO - u'cppunittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:35:17 INFO - u'firefox-45.0.en-US.linux-x86_64.cppunittest.tests.zip'], 12:35:17 INFO - u'jittest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:35:17 INFO - u'jsshell-linux-x86_64.zip'], 12:35:17 INFO - u'mochitest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:35:17 INFO - u'firefox-45.0.en-US.linux-x86_64.mochitest.tests.zip'], 12:35:17 INFO - u'mozbase': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 12:35:17 INFO - u'reftest': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:35:17 INFO - u'firefox-45.0.en-US.linux-x86_64.reftest.tests.zip'], 12:35:17 INFO - u'talos': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:35:17 INFO - u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'], 12:35:17 INFO - u'web-platform': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:35:17 INFO - u'firefox-45.0.en-US.linux-x86_64.web-platform.tests.zip'], 12:35:17 INFO - u'webapprt': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'], 12:35:17 INFO - u'xpcshell': [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', 12:35:17 INFO - u'firefox-45.0.en-US.linux-x86_64.xpcshell.tests.zip']} 12:35:17 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:35:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:17 INFO - https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:35:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:35:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:35:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:35:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:35:18 INFO - Downloaded 21584162 bytes. 12:35:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:35:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:35:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:35:19 INFO - Return code: 0 12:35:19 INFO - Downloading packages: [u'firefox-45.0.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:35:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:35:19 INFO - https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:35:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:35:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:35:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:35:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:35:21 INFO - Downloaded 21584162 bytes. 12:35:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 12:35:21 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip 12:35:21 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:35:23 INFO - Return code: 0 12:35:23 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:35:23 INFO - https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:35:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 12:35:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 12:35:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 12:35:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:35:54 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip: The read operation timed out 12:35:54 INFO - retry: attempt #1 caught exception: The read operation timed out 12:35:54 INFO - retry: Failed, sleeping 30 seconds before retrying 12:36:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #2 12:36:25 INFO - Downloaded 11132038 bytes. 12:36:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 12:36:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip 12:36:25 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:36:26 INFO - Return code: 0 12:36:26 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:36:26 INFO - https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:36:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 12:36:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 12:36:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 12:36:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:36:27 INFO - Downloaded 57943903 bytes. 12:36:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 12:36:27 INFO - mkdir: /builds/slave/test-pgo/properties 12:36:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 12:36:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 12:36:27 INFO - Contents: 12:36:27 INFO - build_url:https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 12:36:28 INFO - Running post-action listener: _resource_record_post_action 12:36:28 INFO - Running post-action listener: set_extra_try_arguments 12:36:28 INFO - ##### 12:36:28 INFO - ##### Running populate-webroot step. 12:36:28 INFO - ##### 12:36:28 INFO - Running pre-action listener: _resource_record_pre_action 12:36:28 INFO - Running main action method: populate_webroot 12:36:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:36:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:36:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:36:28 INFO - '--tppagecycles', 12:36:28 INFO - '7'], 12:36:28 INFO - 'tests': ['tsvgm']}}, 12:36:28 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:36:28 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:36:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:36:28 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:36:28 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:36:28 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:36:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:36:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:28 INFO - 'talos_options': ['--e10s'], 12:36:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:36:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:28 INFO - 'tests': ['damp', 'tps']}, 12:36:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:28 INFO - 'talos_options': ['--e10s'], 12:36:28 INFO - 'tests': ['damp', 'tps']}, 12:36:28 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:36:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:36:28 INFO - 'other': {'tests': ['a11yr', 12:36:28 INFO - 'ts_paint', 12:36:28 INFO - 'tpaint', 12:36:28 INFO - 'sessionrestore', 12:36:28 INFO - 'sessionrestore_no_auto_restore']}, 12:36:28 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:36:28 INFO - 'tests': ['a11yr', 12:36:28 INFO - 'ts_paint', 12:36:28 INFO - 'tpaint', 12:36:28 INFO - 'sessionrestore', 12:36:28 INFO - 'sessionrestore_no_auto_restore']}, 12:36:28 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:36:28 INFO - 'tests': ['a11yr', 12:36:28 INFO - 'ts_paint', 12:36:28 INFO - 'tpaint', 12:36:28 INFO - 'sessionrestore', 12:36:28 INFO - 'sessionrestore_no_auto_restore']}, 12:36:28 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:36:28 INFO - 'tests': ['a11yr', 12:36:28 INFO - 'ts_paint', 12:36:28 INFO - 'tpaint', 12:36:28 INFO - 'sessionrestore', 12:36:28 INFO - 'sessionrestore_no_auto_restore']}, 12:36:28 INFO - 'other_l64': {'tests': ['a11yr', 12:36:28 INFO - 'ts_paint', 12:36:28 INFO - 'tpaint', 12:36:28 INFO - 'sessionrestore', 12:36:28 INFO - 'sessionrestore_no_auto_restore']}, 12:36:28 INFO - 'other_nol64': {'tests': ['a11yr', 12:36:28 INFO - 'ts_paint', 12:36:28 INFO - 'tpaint', 12:36:28 INFO - 'sessionrestore', 12:36:28 INFO - 'sessionrestore_no_auto_restore']}, 12:36:28 INFO - 'svgr': {'tests': ['tsvgx', 12:36:28 INFO - 'tsvgr_opacity', 12:36:28 INFO - 'tart', 12:36:28 INFO - 'tscrollx', 12:36:28 INFO - 'cart']}, 12:36:28 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:36:28 INFO - 'tests': ['tsvgx', 12:36:28 INFO - 'tsvgr_opacity', 12:36:28 INFO - 'tart', 12:36:28 INFO - 'tscrollx', 12:36:28 INFO - 'cart']}, 12:36:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:28 INFO - 'tests': ['tp5o']}, 12:36:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:28 INFO - 'talos_options': ['--e10s'], 12:36:28 INFO - 'tests': ['tp5o']}, 12:36:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:28 INFO - 'talos_options': ['--xperf_path', 12:36:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:36:28 INFO - 'tests': ['tp5n']}, 12:36:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:36:28 INFO - 'talos_options': ['--e10s', 12:36:28 INFO - '--xperf_path', 12:36:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:36:28 INFO - 'tests': ['tp5n']}}, 12:36:28 INFO - 'talos.zip': {'path': '', 12:36:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:36:28 INFO - Running post-action listener: _resource_record_post_action 12:36:28 INFO - ##### 12:36:28 INFO - ##### Running create-virtualenv step. 12:36:28 INFO - ##### 12:36:28 INFO - Running pre-action listener: _resource_record_pre_action 12:36:28 INFO - Running main action method: create_virtualenv 12:36:28 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 12:36:28 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:36:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 12:36:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:36:28 INFO - Using real prefix '/usr' 12:36:28 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 12:36:28 INFO - Installing distribute.............................................................................................................................................................................................done. 12:36:30 INFO - Installing pip.................done. 12:36:30 INFO - Return code: 0 12:36:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 12:36:30 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:36:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:30 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:36:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:30 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fcec57e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, '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': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', '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:36:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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:36:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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:36:30 INFO - Using env: {'DISPLAY': ':0', 12:36:30 INFO - 'HOME': '/home/cltbld', 12:36:30 INFO - 'LANG': 'en_US.UTF-8', 12:36:30 INFO - 'LANGUAGE': 'en_US:en', 12:36:30 INFO - 'LOGNAME': 'cltbld', 12:36:30 INFO - 'MAIL': '/var/mail/cltbld', 12:36:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:30 INFO - 'MOZ_NO_REMOTE': '1', 12:36:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:30 INFO - 'NO_EM_RESTART': '1', 12:36:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:36:30 INFO - 'PWD': '/builds/slave/test-pgo', 12:36:30 INFO - 'SHELL': '/bin/bash', 12:36:30 INFO - 'SHLVL': '1', 12:36:30 INFO - 'TERM': 'linux', 12:36:30 INFO - 'TMOUT': '86400', 12:36:30 INFO - 'USER': 'cltbld', 12:36:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:36:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:30 INFO - '_': '/tools/buildbot/bin/python'} 12:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:31 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:36:31 INFO - Cleaning up... 12:36:31 INFO - Return code: 0 12:36:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 12:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fcec57e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, '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': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', '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:36:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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:36:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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:36:31 INFO - Using env: {'DISPLAY': ':0', 12:36:31 INFO - 'HOME': '/home/cltbld', 12:36:31 INFO - 'LANG': 'en_US.UTF-8', 12:36:31 INFO - 'LANGUAGE': 'en_US:en', 12:36:31 INFO - 'LOGNAME': 'cltbld', 12:36:31 INFO - 'MAIL': '/var/mail/cltbld', 12:36:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:31 INFO - 'MOZ_NO_REMOTE': '1', 12:36:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:31 INFO - 'NO_EM_RESTART': '1', 12:36:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:36:31 INFO - 'PWD': '/builds/slave/test-pgo', 12:36:31 INFO - 'SHELL': '/bin/bash', 12:36:31 INFO - 'SHLVL': '1', 12:36:31 INFO - 'TERM': 'linux', 12:36:31 INFO - 'TMOUT': '86400', 12:36:31 INFO - 'USER': 'cltbld', 12:36:31 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:36:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:31 INFO - '_': '/tools/buildbot/bin/python'} 12:36:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:31 INFO - Downloading/unpacking psutil>=0.7.1 12:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:33 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 12:36:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:36:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:36:33 INFO - Installing collected packages: psutil 12:36:33 INFO - Running setup.py install for psutil 12:36:33 INFO - building 'psutil._psutil_linux' extension 12:36:33 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:36:33 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:36:33 INFO - building 'psutil._psutil_posix' extension 12:36:33 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:36:33 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:36:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:36:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:36:33 INFO - Successfully installed psutil 12:36:33 INFO - Cleaning up... 12:36:33 INFO - Return code: 0 12:36:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 12:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:33 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fcec57e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, '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': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', '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:36:33 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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:36:33 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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:36:33 INFO - Using env: {'DISPLAY': ':0', 12:36:33 INFO - 'HOME': '/home/cltbld', 12:36:33 INFO - 'LANG': 'en_US.UTF-8', 12:36:33 INFO - 'LANGUAGE': 'en_US:en', 12:36:33 INFO - 'LOGNAME': 'cltbld', 12:36:33 INFO - 'MAIL': '/var/mail/cltbld', 12:36:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:33 INFO - 'MOZ_NO_REMOTE': '1', 12:36:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:33 INFO - 'NO_EM_RESTART': '1', 12:36:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:36:33 INFO - 'PWD': '/builds/slave/test-pgo', 12:36:33 INFO - 'SHELL': '/bin/bash', 12:36:33 INFO - 'SHLVL': '1', 12:36:33 INFO - 'TERM': 'linux', 12:36:33 INFO - 'TMOUT': '86400', 12:36:33 INFO - 'USER': 'cltbld', 12:36:33 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:36:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:33 INFO - '_': '/tools/buildbot/bin/python'} 12:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:34 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:36:34 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:36:34 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:36:34 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:36:34 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:36:34 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:36:34 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:36:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:36:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:36:35 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:36:35 INFO - Installing collected packages: mozsystemmonitor 12:36:35 INFO - Running setup.py install for mozsystemmonitor 12:36:36 INFO - Successfully installed mozsystemmonitor 12:36:36 INFO - Cleaning up... 12:36:36 INFO - Return code: 0 12:36:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 12:36: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:36:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36: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:36:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:36 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fcec57e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, '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': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', '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:36:36 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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:36:36 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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:36:36 INFO - Using env: {'DISPLAY': ':0', 12:36:36 INFO - 'HOME': '/home/cltbld', 12:36:36 INFO - 'LANG': 'en_US.UTF-8', 12:36:36 INFO - 'LANGUAGE': 'en_US:en', 12:36:36 INFO - 'LOGNAME': 'cltbld', 12:36:36 INFO - 'MAIL': '/var/mail/cltbld', 12:36:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:36 INFO - 'MOZ_NO_REMOTE': '1', 12:36:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:36 INFO - 'NO_EM_RESTART': '1', 12:36:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:36:36 INFO - 'PWD': '/builds/slave/test-pgo', 12:36:36 INFO - 'SHELL': '/bin/bash', 12:36:36 INFO - 'SHLVL': '1', 12:36:36 INFO - 'TERM': 'linux', 12:36:36 INFO - 'TMOUT': '86400', 12:36:36 INFO - 'USER': 'cltbld', 12:36:36 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:36:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:36 INFO - '_': '/tools/buildbot/bin/python'} 12:36:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:36 INFO - Downloading/unpacking blobuploader==1.2.4 12:36:36 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:36:36 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:36:36 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:36:36 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:36:36 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:36:36 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:36:38 INFO - Downloading blobuploader-1.2.4.tar.gz 12:36:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:36:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:36:38 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:36:38 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:36:38 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:36:38 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:36:38 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:36:38 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:36:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 12:36:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:36:38 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:36:38 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:36:38 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:36:38 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:36:38 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:36:38 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:36:38 INFO - Downloading docopt-0.6.1.tar.gz 12:36:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 12:36:38 INFO - Installing collected packages: blobuploader, requests, docopt 12:36:38 INFO - Running setup.py install for blobuploader 12:36:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:36:38 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 12:36:39 INFO - Running setup.py install for requests 12:36:39 INFO - Running setup.py install for docopt 12:36:39 INFO - Successfully installed blobuploader requests docopt 12:36:39 INFO - Cleaning up... 12:36:39 INFO - Return code: 0 12:36:39 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:39 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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 0x7fcec57e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, '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': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', '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:36:39 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--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:36:39 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --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:36:39 INFO - Using env: {'DISPLAY': ':0', 12:36:39 INFO - 'HOME': '/home/cltbld', 12:36:39 INFO - 'LANG': 'en_US.UTF-8', 12:36:39 INFO - 'LANGUAGE': 'en_US:en', 12:36:39 INFO - 'LOGNAME': 'cltbld', 12:36:39 INFO - 'MAIL': '/var/mail/cltbld', 12:36:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:39 INFO - 'MOZ_NO_REMOTE': '1', 12:36:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:39 INFO - 'NO_EM_RESTART': '1', 12:36:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:36:39 INFO - 'PWD': '/builds/slave/test-pgo', 12:36:39 INFO - 'SHELL': '/bin/bash', 12:36:39 INFO - 'SHLVL': '1', 12:36:39 INFO - 'TERM': 'linux', 12:36:39 INFO - 'TMOUT': '86400', 12:36:39 INFO - 'USER': 'cltbld', 12:36:39 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:36:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:39 INFO - '_': '/tools/buildbot/bin/python'} 12:36:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:36:39 INFO - Running setup.py (path:/tmp/pip-TeG_9e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:36:39 INFO - Running setup.py (path:/tmp/pip-nRBQ7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:36:39 INFO - Running setup.py (path:/tmp/pip-CgNhRV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:36:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:36:39 INFO - Running setup.py (path:/tmp/pip-1_N1KW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:36:40 INFO - Running setup.py (path:/tmp/pip-ANXZqP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:36:40 INFO - Running setup.py (path:/tmp/pip-iA3BKj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:36:40 INFO - Running setup.py (path:/tmp/pip-QoMWJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:36:40 INFO - Running setup.py (path:/tmp/pip-66BsO3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:36:40 INFO - Running setup.py (path:/tmp/pip-T35SSa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:36:40 INFO - Running setup.py (path:/tmp/pip-_lOxDB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:36:40 INFO - Running setup.py (path:/tmp/pip-s1yCV6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:36:40 INFO - Running setup.py (path:/tmp/pip-Uqo0LS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:36:40 INFO - Running setup.py (path:/tmp/pip-atc9AI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:36:40 INFO - Running setup.py (path:/tmp/pip-SOIcG4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:36:40 INFO - Running setup.py (path:/tmp/pip-IZT0x8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:36:40 INFO - Running setup.py (path:/tmp/pip-E1XrDm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:36:40 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:36:40 INFO - Running setup.py (path:/tmp/pip-YZNYub-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:36:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:36:40 INFO - Running setup.py install for manifestparser 12:36:41 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Running setup.py install for mozcrash 12:36:41 INFO - Running setup.py install for mozdebug 12:36:41 INFO - Running setup.py install for mozdevice 12:36:41 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Running setup.py install for mozfile 12:36:41 INFO - Running setup.py install for mozhttpd 12:36:41 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Running setup.py install for mozinfo 12:36:41 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Running setup.py install for mozInstall 12:36:41 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Running setup.py install for mozleak 12:36:41 INFO - Running setup.py install for mozlog 12:36:41 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 12:36:41 INFO - Running setup.py install for moznetwork 12:36:42 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 12:36:42 INFO - Running setup.py install for mozprocess 12:36:42 INFO - Running setup.py install for mozprofile 12:36:42 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 12:36:42 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 12:36:42 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 12:36:42 INFO - Running setup.py install for mozrunner 12:36:42 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 12:36:42 INFO - Running setup.py install for mozscreenshot 12:36:42 INFO - Running setup.py install for moztest 12:36:42 INFO - Running setup.py install for mozversion 12:36:42 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 12:36:42 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:36:42 INFO - Cleaning up... 12:36:42 INFO - Return code: 0 12:36:42 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:42 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fcec57e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, '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': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', '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:36:42 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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:36:42 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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:36:42 INFO - Using env: {'DISPLAY': ':0', 12:36:42 INFO - 'HOME': '/home/cltbld', 12:36:42 INFO - 'LANG': 'en_US.UTF-8', 12:36:42 INFO - 'LANGUAGE': 'en_US:en', 12:36:42 INFO - 'LOGNAME': 'cltbld', 12:36:42 INFO - 'MAIL': '/var/mail/cltbld', 12:36:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:42 INFO - 'MOZ_NO_REMOTE': '1', 12:36:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:42 INFO - 'NO_EM_RESTART': '1', 12:36:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:36:42 INFO - 'PWD': '/builds/slave/test-pgo', 12:36:42 INFO - 'SHELL': '/bin/bash', 12:36:42 INFO - 'SHLVL': '1', 12:36:42 INFO - 'TERM': 'linux', 12:36:42 INFO - 'TMOUT': '86400', 12:36:42 INFO - 'USER': 'cltbld', 12:36:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:36:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:42 INFO - '_': '/tools/buildbot/bin/python'} 12:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:36:42 INFO - Running setup.py (path:/tmp/pip-7EcTm3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:36:43 INFO - Running setup.py (path:/tmp/pip-Yz3T1U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:36:43 INFO - Running setup.py (path:/tmp/pip-pShqIA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:36:43 INFO - Running setup.py (path:/tmp/pip-bg124h-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 12:36:43 INFO - Running setup.py (path:/tmp/pip-I9Q3h4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:36:43 INFO - Running setup.py (path:/tmp/pip-nJf0Mr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:36:43 INFO - Running setup.py (path:/tmp/pip-uEvmJf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:36:43 INFO - Running setup.py (path:/tmp/pip-U25n1t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 12:36:43 INFO - Running setup.py (path:/tmp/pip-0gibY7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 12:36:43 INFO - Running setup.py (path:/tmp/pip-Bto194-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:36:43 INFO - Running setup.py (path:/tmp/pip-WR3Ztj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:36:43 INFO - Running setup.py (path:/tmp/pip-ph6pQN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:36:43 INFO - Running setup.py (path:/tmp/pip-IfjMNq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:36:43 INFO - Running setup.py (path:/tmp/pip-Zv0WcU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 12:36:43 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:36:43 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:36:43 INFO - Running setup.py (path:/tmp/pip-tHHm9i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 12:36:44 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:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 12:36:44 INFO - Running setup.py (path:/tmp/pip-mD84lL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 12:36:44 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:36:44 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 12:36:44 INFO - Running setup.py (path:/tmp/pip-seu40g-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 12:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 12:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:36:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:36:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:36:45 INFO - Downloading blessings-1.6.tar.gz 12:36:45 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 12:36:46 INFO - Installing collected packages: blessings 12:36:46 INFO - Running setup.py install for blessings 12:36:46 INFO - Successfully installed blessings 12:36:46 INFO - Cleaning up... 12:36:46 INFO - Return code: 0 12:36:46 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 12:36:46 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:36:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:36:46 INFO - Reading from file tmpfile_stdout 12:36:46 INFO - Current package versions: 12:36:46 INFO - argparse == 1.2.1 12:36:46 INFO - blessings == 1.6 12:36:46 INFO - blobuploader == 1.2.4 12:36:46 INFO - docopt == 0.6.1 12:36:46 INFO - manifestparser == 1.1 12:36:46 INFO - mozInstall == 1.12 12:36:46 INFO - mozcrash == 0.16 12:36:46 INFO - mozdebug == 0.1 12:36:46 INFO - mozdevice == 0.47 12:36:46 INFO - mozfile == 1.2 12:36:46 INFO - mozhttpd == 0.7 12:36:46 INFO - mozinfo == 0.9 12:36:46 INFO - mozleak == 0.1 12:36:46 INFO - mozlog == 3.1 12:36:46 INFO - moznetwork == 0.27 12:36:46 INFO - mozprocess == 0.22 12:36:46 INFO - mozprofile == 0.27 12:36:46 INFO - mozrunner == 6.11 12:36:46 INFO - mozscreenshot == 0.1 12:36:46 INFO - mozsystemmonitor == 0.0 12:36:46 INFO - moztest == 0.7 12:36:46 INFO - mozversion == 1.4 12:36:46 INFO - psutil == 3.1.1 12:36:46 INFO - requests == 1.2.3 12:36:46 INFO - wsgiref == 0.1.2 12:36:46 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 12:36:46 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:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:46 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:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fcec57e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, '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': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', '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:36:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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:36:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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:36:46 INFO - Using env: {'DISPLAY': ':0', 12:36:46 INFO - 'HOME': '/home/cltbld', 12:36:46 INFO - 'LANG': 'en_US.UTF-8', 12:36:46 INFO - 'LANGUAGE': 'en_US:en', 12:36:46 INFO - 'LOGNAME': 'cltbld', 12:36:46 INFO - 'MAIL': '/var/mail/cltbld', 12:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:46 INFO - 'MOZ_NO_REMOTE': '1', 12:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:46 INFO - 'NO_EM_RESTART': '1', 12:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:36:46 INFO - 'PWD': '/builds/slave/test-pgo', 12:36:46 INFO - 'SHELL': '/bin/bash', 12:36:46 INFO - 'SHLVL': '1', 12:36:46 INFO - 'TERM': 'linux', 12:36:46 INFO - 'TMOUT': '86400', 12:36:46 INFO - 'USER': 'cltbld', 12:36:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:46 INFO - '_': '/tools/buildbot/bin/python'} 12:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 INFO - Cleaning up... 12:36:46 INFO - Return code: 0 12:36:46 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 12:36:46 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:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:46 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:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:46 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fcec57e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, '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': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', '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:36:46 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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:36:46 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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:36:46 INFO - Using env: {'DISPLAY': ':0', 12:36:46 INFO - 'HOME': '/home/cltbld', 12:36:46 INFO - 'LANG': 'en_US.UTF-8', 12:36:46 INFO - 'LANGUAGE': 'en_US:en', 12:36:46 INFO - 'LOGNAME': 'cltbld', 12:36:46 INFO - 'MAIL': '/var/mail/cltbld', 12:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:46 INFO - 'MOZ_NO_REMOTE': '1', 12:36:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:46 INFO - 'NO_EM_RESTART': '1', 12:36:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:36:46 INFO - 'PWD': '/builds/slave/test-pgo', 12:36:46 INFO - 'SHELL': '/bin/bash', 12:36:46 INFO - 'SHLVL': '1', 12:36:46 INFO - 'TERM': 'linux', 12:36:46 INFO - 'TMOUT': '86400', 12:36:46 INFO - 'USER': 'cltbld', 12:36:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:46 INFO - '_': '/tools/buildbot/bin/python'} 12:36:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:46 INFO - Downloading/unpacking jsonschema 12:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:46 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:36:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:36:48 INFO - Downloading/unpacking functools32 (from jsonschema) 12:36:48 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:36:48 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:36:48 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:36:48 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:36:48 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:36:48 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:36:48 INFO - Downloading functools32-3.2.3-2.tar.gz 12:36:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 12:36:48 INFO - warning: no files found matching '*.txt' 12:36:48 INFO - no previously-included directories found matching 'build' 12:36:48 INFO - no previously-included directories found matching 'dist' 12:36:48 INFO - no previously-included directories found matching '.git*' 12:36:48 INFO - Installing collected packages: jsonschema, functools32 12:36:49 INFO - Running setup.py install for functools32 12:36:49 INFO - warning: no files found matching '*.txt' 12:36:49 INFO - no previously-included directories found matching 'build' 12:36:49 INFO - no previously-included directories found matching 'dist' 12:36:49 INFO - no previously-included directories found matching '.git*' 12:36:49 INFO - Successfully installed jsonschema functools32 12:36:49 INFO - Cleaning up... 12:36:49 INFO - Return code: 0 12:36:49 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 12:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:36:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:36:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:36:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:36:49 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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 0x7fcec57e0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1102600>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, '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': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', '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:36:49 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--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:36:49 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --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:36:49 INFO - Using env: {'DISPLAY': ':0', 12:36:49 INFO - 'HOME': '/home/cltbld', 12:36:49 INFO - 'LANG': 'en_US.UTF-8', 12:36:49 INFO - 'LANGUAGE': 'en_US:en', 12:36:49 INFO - 'LOGNAME': 'cltbld', 12:36:49 INFO - 'MAIL': '/var/mail/cltbld', 12:36:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:36:49 INFO - 'MOZ_NO_REMOTE': '1', 12:36:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:36:49 INFO - 'NO_EM_RESTART': '1', 12:36:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:36:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:36:49 INFO - 'PWD': '/builds/slave/test-pgo', 12:36:49 INFO - 'SHELL': '/bin/bash', 12:36:49 INFO - 'SHLVL': '1', 12:36:49 INFO - 'TERM': 'linux', 12:36:49 INFO - 'TMOUT': '86400', 12:36:49 INFO - 'USER': 'cltbld', 12:36:49 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:36:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:36:49 INFO - '_': '/tools/buildbot/bin/python'} 12:36:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:36:49 INFO - Downloading/unpacking flake8 12:36:49 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:36:49 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:36:49 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:36:49 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:36:49 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:36:49 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:36:51 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 12:36:51 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 12:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 12:36:51 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 12:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 12:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 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:36:51 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 12:36:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:36:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:36:51 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:36:51 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:36:51 INFO - no previously-included directories found matching 'docs/_build' 12:36:51 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 12:36:51 INFO - Running setup.py install for pep8 12:36:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 12:36:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 12:36:52 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 12:36:52 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 12:36:52 INFO - no previously-included directories found matching 'docs/_build' 12:36:52 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 12:36:52 INFO - Successfully installed flake8 mccabe pyflakes pep8 12:36:52 INFO - Cleaning up... 12:36:52 INFO - Return code: 0 12:36:52 INFO - Running post-action listener: _resource_record_post_action 12:36:52 INFO - Running post-action listener: _start_resource_monitoring 12:36:52 INFO - Starting resource monitoring. 12:36:52 INFO - ##### 12:36:52 INFO - ##### Running install step. 12:36:52 INFO - ##### 12:36:52 INFO - Running pre-action listener: _resource_record_pre_action 12:36:52 INFO - Running main action method: install 12:36:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 12:36:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 12:36:52 INFO - Reading from file tmpfile_stdout 12:36:52 INFO - Detecting whether we're running mozinstall >=1.0... 12:36:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 12:36:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 12:36:52 INFO - Reading from file tmpfile_stdout 12:36:52 INFO - Output received: 12:36:52 INFO - Usage: mozinstall [options] installer 12:36:52 INFO - Options: 12:36:52 INFO - -h, --help show this help message and exit 12:36:52 INFO - -d DEST, --destination=DEST 12:36:52 INFO - Directory to install application into. [default: 12:36:52 INFO - "/builds/slave/test-pgo"] 12:36:52 INFO - --app=APP Application being installed. [default: firefox] 12:36:52 INFO - mkdir: /builds/slave/test-pgo/build/application 12:36:52 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 12:36:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 12:37:06 INFO - Reading from file tmpfile_stdout 12:37:06 INFO - Output received: 12:37:06 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 12:37:06 INFO - Running post-action listener: _resource_record_post_action 12:37:06 INFO - ##### 12:37:06 INFO - ##### Running run-tests step. 12:37:06 INFO - ##### 12:37:06 INFO - Running pre-action listener: _resource_record_pre_action 12:37:06 INFO - Running main action method: run_tests 12:37:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 12:37:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 12:37:07 INFO - Python 2.7.3 12:37:07 INFO - Return code: 0 12:37:07 INFO - grabbing minidump binary from tooltool 12:37:07 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:37:07 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 0x1191350>, '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 0x1192250>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x11926e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 12:37:07 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:37:07 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:37:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:37:07 INFO - Return code: 0 12:37:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 12:37:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 12:37:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 12:37:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 12:37:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 12:37:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 12:37:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 12:37:08 INFO - Return code: 0 12:37:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 12:37:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost 12:37:08 INFO - Using env: {'DISPLAY': ':0', 12:37:08 INFO - 'HOME': '/home/cltbld', 12:37:08 INFO - 'LANG': 'en_US.UTF-8', 12:37:08 INFO - 'LANGUAGE': 'en_US:en', 12:37:08 INFO - 'LOGNAME': 'cltbld', 12:37:08 INFO - 'MAIL': '/var/mail/cltbld', 12:37:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:37:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 12:37:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:37:08 INFO - 'MOZ_NO_REMOTE': '1', 12:37:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 12:37:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:37:08 INFO - 'NO_EM_RESTART': '1', 12:37:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:37:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 12:37:08 INFO - 'PWD': '/builds/slave/test-pgo', 12:37:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 12:37:08 INFO - 'SHELL': '/bin/bash', 12:37:08 INFO - 'SHLVL': '1', 12:37:08 INFO - 'TERM': 'linux', 12:37:08 INFO - 'TMOUT': '86400', 12:37:08 INFO - 'USER': 'cltbld', 12:37:08 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922', 12:37:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:37:08 INFO - '_': '/tools/buildbot/bin/python'} 12:37:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost'] with output_timeout 3600 12:37:08 INFO - mozversion INFO | application_buildid: 20160229100424 12:37:08 INFO - mozversion INFO | application_changeset: bd8994cd01487cf2e8c11d98c62178ae17904841 12:37:08 INFO - mozversion INFO | application_display_name: Nightly 12:37:08 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:37:08 INFO - mozversion INFO | application_name: Firefox 12:37:08 INFO - mozversion INFO | application_remotingname: firefox 12:37:08 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:37:08 INFO - mozversion INFO | application_vendor: Mozilla 12:37:08 INFO - mozversion INFO | application_version: 45.0 12:37:08 INFO - mozversion INFO | platform_buildid: 20160229100424 12:37:08 INFO - mozversion INFO | platform_changeset: bd8994cd01487cf2e8c11d98c62178ae17904841 12:37:08 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:37:08 INFO - mozversion INFO | platform_version: 45.0 12:37:08 INFO - 2016-02-29 12:37:08,350 DEBUG : using testdate: 1456778228 12:37:08 INFO - 2016-02-29 12:37:08,350 DEBUG : actual date: 1456778228 12:37:08 INFO - 2016-02-29 12:37:08,358 INFO : starting webserver on 'localhost:33544' 12:37:08 INFO - 2016-02-29 12:37:08,359 INFO : Starting test suite talos-linux64-ix-028 12:37:08 INFO - 2016-02-29 12:37:08,360 INFO : Starting test dromaeo_css 12:37:08 INFO - 2016-02-29 12:37:08,360 DEBUG : operating with platform_type : linux_ 12:37:08 INFO - 2016-02-29 12:37:08,360 INFO : Initialising browser for dromaeo_css test... 12:37:08 INFO - 2016-02-29 12:37:08,375 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpENPmVT/profile http://localhost:33544/getInfo.html 12:37:12 INFO - 2016-02-29 12:37:12,253 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:37:12 INFO - 2016-02-29 12:37:12,253 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:37:12 INFO - 2016-02-29 12:37:12,253 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:37:12 INFO - 2016-02-29 12:37:12,253 DEBUG : BROWSER_OUTPUT: __metrics 12:37:12 INFO - 2016-02-29 12:37:12,458 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:37:13 INFO - 2016-02-29 12:37:13,609 INFO : Browser initialized. 12:37:13 INFO - 2016-02-29 12:37:13,610 INFO : Running cycle 1/1 for dromaeo_css test... 12:37:13 INFO - 2016-02-29 12:37:13,610 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpENPmVT/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:37:25 INFO - 2016-02-29 12:37:25,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 134283264 12:37:25 INFO - 2016-02-29 12:37:25,302 DEBUG : BROWSER_OUTPUT: 12:38:16 INFO - 2016-02-29 12:38:16,014 DEBUG : BROWSER_OUTPUT: 1456778296013 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:40:24 INFO - 2016-02-29 12:40:24,028 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33544/tests/dromaeo/cssquery-ext.html) 12:40:25 INFO - 2016-02-29 12:40:25,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 251052032 12:40:25 INFO - 2016-02-29 12:40:25,214 DEBUG : BROWSER_OUTPUT: 12:43:27 INFO - 2016-02-29 12:43:27,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/dromaeo/cssquery-ext.html (next: http://localhost:33544/tests/dromaeo/cssquery-jquery.html) 12:43:27 INFO - 2016-02-29 12:43:27,921 DEBUG : BROWSER_OUTPUT: RSS: Main: 209633280 12:43:27 INFO - 2016-02-29 12:43:27,921 DEBUG : BROWSER_OUTPUT: 12:46:29 INFO - 2016-02-29 12:46:29,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33544/tests/dromaeo/cssquery-mootools.html) 12:46:30 INFO - 2016-02-29 12:46:30,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 214581248 12:46:30 INFO - 2016-02-29 12:46:30,266 DEBUG : BROWSER_OUTPUT: 12:49:31 INFO - 2016-02-29 12:49:31,997 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33544/tests/dromaeo/cssquery-prototype.html) 12:49:32 INFO - 2016-02-29 12:49:32,564 DEBUG : BROWSER_OUTPUT: RSS: Main: 205299712 12:49:32 INFO - 2016-02-29 12:49:32,564 DEBUG : BROWSER_OUTPUT: 12:52:34 INFO - 2016-02-29 12:52:34,868 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33544/tests/dromaeo/cssquery-yui.html) 12:52:35 INFO - 2016-02-29 12:52:35,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 198385664 12:52:35 INFO - 2016-02-29 12:52:35,435 DEBUG : BROWSER_OUTPUT: 12:55:37 INFO - 2016-02-29 12:55:37,530 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/dromaeo/cssquery-yui.html (next: http://localhost:33544/tests/dromaeo/cssquery-dojo.html) 12:55:37 INFO - 2016-02-29 12:55:37,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 241508352 12:55:37 INFO - 2016-02-29 12:55:37,780 DEBUG : BROWSER_OUTPUT: 12:55:37 INFO - 2016-02-29 12:55:37,780 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:55:37 INFO - 2016-02-29 12:55:37,780 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:55:37 INFO - 2016-02-29 12:55:37,780 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:55:37 INFO - 2016-02-29 12:55:37,780 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:55:37 INFO - 2016-02-29 12:55:37,780 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3241.708246257837;3289.8684052637896;3314.8839790607317;3316.9834150829242;3334.433146365118;5406.513413792758;5418.83743487695;5436.510714035736;5452.890942181149;5467.753951072202;5396.217548455472;5433.6196466247375;5457.072297709389;5479.643823151492;5480.862978425542;4847.394075740533;4920.434150072751;4941.160002799524;4986.127427700156;5014.172661510846;4976.800927962877;4979.875503112433;5038.546530812227;5038.874028149307;5043.344365232515;4922.8523144305545;4992.450830408652;5010.348654674905;5028.748562571856;5062.772175252123;4966.15575352191;5034.320366750479;5037.168867136918;5043.697378157322;5063.518965698253;4777.498362671904;4954.7274899880495;4975.527324904128;4995;5028.723420211887;5169.276301317818;5184.688918664892;5193.039287731744;5196.350456192976;5206.739663016834;5707.34365547959;5730.05454100073;5760.683162426065;5763.1355296705415;5797.884042319172;5695.943040569583;5749.195112684228;5755.22304488897;5761.423857614247;5791.333996590404;5386.91919621206;5409.29679141709;5471.398146203915;5476.835694929118;5481.671099734029;5916.852078697981;5920.5559583031445;5922.318933322723;5924.970375148183;5925.318588362307;5633.63381380209;5740.971295143581;5748.48263656273;5754.338251101093;5759;5780.653160810365;5812.070068789058;5815.9709201453725;5847.853803654858;5848.3274423441;5794.072948328248;5818.970905145447;5834.416558344132;5835.591508594358;5847.06446968483;5631.746571404296;5638.379778224392;5837.854053648608;5841.591088623755;5841.678707671034;4323.200207961537;4362.541933097043;4459.0413061192;4467.950031742538;4473.977630111829;4025.4766880305374;4026.255142798533;4028.436018957348;4050.23045621331;4055.3511438169753;5535.944640553543;5538.9169162461785;5540;5540;5565.41563135873;5654.462826031603;5706.771729130788;5814.215080964101;5861.120831875252;5933.495652869468;5527.668339899619;5563.749631266603;5569.805056823073;5571.832845014656;5573.080441727069;5054.166062599704;5081.644284900021;5092.236164575269;5093.083245015932;5119.846404607868;5886.3230728465915;5894.67579283135;5935.881282374328;5993.190919225936;5998.640081595118;5840.970795145997;5893.734781934738;5895.056790913433;5900.055991041584;5906.70466476683;5767.5674324425;5955.076963070731;5989.64062156272;5997.400259973968;6017.669028203491;5684.3747187808485;5712.6001179917;5738.110592858114;5738.1679656450415;5772.105323674838;5918.73365698536;5947.316058653138;5952.107183922446;5955.642661440327;5955.970220148872;5573.247611572548;5677.7161141941915;5768.134779783066;5823.417658234142;5827.59206855516;5610.298712660918;5676.2337084493065;5679.091345384719;5680.886382272414;5705.885882282414;5638.774449021993;5649.604527683187;5652.434756524314;5652.63257888236;5657.2928383952;5595.552355811444;5660.094384898396;5666.065099258741;5720.542356611378;5720.570957178312;5616.297962754656;5619.747111379916;5627.324721033502;5687.317521897398;5710.2576665033275 12:55:37 INFO - 2016-02-29 12:55:37,781 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.2131059138388;621.6208113051038;621.6363427394974;625.2559454249446;629.4712441549098;32315.192120197007;33091.33817323655;33125.834370828175;33151;33165.170870728245;33488.330233395376;34022.48966265502;41097.589024109824;41250.79374603123;41476;9024.639014439415;9156.359054866161;9158.313126515504;9160.17558419742;9201.401908875901;8481;8972.685955991541;9065.728028159167;9069.909300907006;9076.727698169032;8434.62044208012;10758.731031724192;10982.945085274603;10985.945070274638;10989.285696429746;10662.200334974868;10742.731431714192;10748.086412654933;10758.139348852073;10763.677089687322;10565.207609429246;10665.946670266676;10684.35893846364;10685.626003089932;10691.411972341519;42401.151976960595;42694.146117077486;42838;42863;42880.35679464779;3656.2687462507606;3735.8505659773577;3746.83139258734;3787.1857550626473;3817.790021548814;30714.53928191079;31030.224244393845;31173.532397013838;31236.531452028237;31734;4266.082792199661;4328.653707703376;4357.085012147453;4369.104333611602;4379.671524635633;286731;290300;290598;292053;293390;59695.403045969855;60870;64538.35461645323;64714;72454.2754572458;65053.67473162604;65066.02400963989;65494.345056548824;65494.67252663706;65502.34497655058;17691.469255922344;17892.821071789374;17927.462176134737;17954.5511362217;18001.7299740504;13602.387892544859;13695.794563081561;13698.178109313472;13756.793648095287;13762.380692868845;22068.779312206992;22404.775952240594;22408.327750167522;22466;22535;7920.6039698014865;8118.594070296462;8189.590520473953;8189.795255118551;8280.337572994145;1040.401768982838;1075.0539525217757;1116.8603924509437;1182.7930112230497;1206.6138835572533;29959.550606740915;29998.550021749692;30688.53967190494;31029.224269392995;31110.68889311078;1088.3252383522108;1165.7642898527588;1192.5587532612988;1210.6186551236333;1241.5592464675092;13998.300084995913;15661.921690391475;15997.520074397788;16005.791438785864;16798.992060476165;542199;558939;560511;560684;562183;58305.416945830846;59479.40520594825;59807.70096149491;59919.400805992256;59985.70007149936;1434.454907135282;1459.4162335065846;1465.1794994802945;1468.0677769616157;1482.7627579587215;31436;31578.842105789325;31627.683723162474;31933.20166995844;32311.192220194684;49954;50958;51020.48979510306;51030.23454648258;51103.233451499;254310;257287;257767;258214;258815;37139;44230.11539769251;44260.55739442565;44313.11373772571;52786.94426111533;50492.24261636005;50692.49307506878;51066.48933510766;51504.74247628738;51706;42159.578404215565;42299.365509518;43200.56799431965;43782.56217437785;44104;42555.14889702127;43813;44147.77926110349;45541;48159.03681926272;40882.962519039414;41821.37267940922;42447.787761060994;42494.36258456187;42558.36162457504;37351.626483735905;37815;41003.794981024905;41339.586604133576;41554.437128249825;28139.700783709126;28498.857505712338;28648.570271446362;28828;28943.13170604885 12:55:37 INFO - 2016-02-29 12:55:37,783 DEBUG : BROWSER_OUTPUT: |2;jquery.html;379.1072025380231;379.96580307772297;382.2584186677845;384.2085304273197;385.339143369122;14966.850331496682;16372.426965056226;17932.820671793277;19583.608327833434;19600.411987640357;11636.360000200008;12011.819822702644;12012.219205751642;19350.322738704148;19667.901660491676;5118.872028199296;5243.003829272445;5243.2135179723155;5243.79024839006;5249.501297376743;3980.6417422431973;4087.57080506547;5202.453742357055;5507.008738427082;5666.150077488369;5605.439456054382;5626.043572592669;5631.18347839563;5653;5660.2075709400515;5486.835394938158;5657.632253903483;5661.207430959669;5661.320641523023;5665.603407761479;5451.918221226685;5460.208269800856;5471.288732464794;5477.698726570037;5494.120940649477;14190.935679823951;14196.858031419657;19857.404277871687;19995.70027948193;21412.036458359413;2209.3151123151874;2237.0604346174646;2238.473958619723;2244.16965722682;2305.9077636894503;10223.897761022368;10340.689779306633;10342.276040677156;10390.48047597617;10924.563017479291;1845.308009496439;1931.9130639121133;1941.9708704369305;1972.2209727157835;2001.1395100106947;62238.68880655613;65455.67272163656;66155.66922165359;66465.3353466464;67730.66134669345;10698;10892.509837057352;11002.394868282321;11004.174686898514;11055.06031987274;14176.432942682177;14338.56984290473;14344.354504047344;14348.928255358865;14356.282185890665;8137.511749295061;8194.426390152632;8197.303229225583;8243.95878020618;8255.504669719836;7686.385089192851;7698.42261830365;7735.61321933901;7743;7757.26306000929;4583.793729282191;4648.86053418398;4665.160271151225;4676.3453116563705;4690.81236750533;1752.0190023752969;1812.3928483958023;1855.6010457751647;1884.5100273928877;1904.495308743184;888.7022847346083;963.4363897120263;977.3549457358109;1041.4063983529468;1050.5220124843179;15127.924360378127;17588.560285992953;17824.3761468348;18019.18913648889;18466.446006619823;984.4487087231173;994.6817018553993;1015.1371334365878;1036.0727149201423;1065.350136416785;10042.14641755459;10220.131288840532;10225.795484090277;10329.741756455998;10357.896421035693;591795;598631;610712;610988;616937;80739.59630201811;81336.59331703304;82812.58593706993;83357;84704;1120.4229821641861;1149.655103468956;1150.9827352589718;1169.906407487399;1187.9524819007142;15575.766363504783;15713.842861571238;15724.528264152093;15725.44960926362;15897.68204635924;34366.82816585901;34676.82661586676;35092.298154037286;35422.822885885405;36092;43356;43364.56635433605;43757.12485750331;47552.762236189985;52346.21480677869;10343.586256549654;10448.373097614167;10629.20280978945;10643.521041553304;10665;12509.56216532417;12537.122401432178;12666.366681665695;14241.50154744579;16599.83400165983;13391.196528208338;15118.546443606709;15203.163825989677;15583.766243506583;15643.765343520085;14824.703505930036;14865.405383784528;15314.540563782659;15330.616734581725;15530.844691553391;14848.62878428048;15323.61690957735;15414.768778468557;15609.297581608627;15812;10255.897441025494;10502.632407865687;10506.317089389166;10515.631952881613;10554.788904222027;12765.170263932814;14944.775828362366;15082;15103.924480377527;15495.535133946 12:55:37 INFO - 2016-02-29 12:55:37,784 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1508.8491150884909;1510.4939845151873;1684.6883326584582;1816.320926633217;1846.5845184833406;7525.774226773192;7876.5667888266125;7880.369570434365;7894.526328420299;7895.40784441167;6675.532712710112;6761.459083273338;7499.062617172854;7681.462297639167;7825.608719564013;2302.5279817637343;2310;2337.754535773745;2338.286822519131;2338.976610233893;2035.8880261585607;2340.426595484109;2353.2469609724894;2421.4793819328843;2423.200343886513;2026.564288677934;2244.9438764030865;2339.9883000584973;2343.6015877300815;2344;2284.9543009139807;2321.8839058047115;2323.2217207235594;2363.61000434928;2364.243442098529;2319;2335.3927978725656;2342.9648555271515;2350.9647355289685;2366.1718398560365;7610.8477830443635;7661.46770645873;7676.347510461617;7677.11713152989;7694;4640.837570685044;4728.40894888139;4728.66899317048;4729.125111854318;4731.668783185179;3117.0804612639326;3171.2389026633673;3179.205198700325;3180.793248438844;3229.337985712923;1066.1311031509372;1094.3652681444744;1102.5920409448556;1120.1207052463776;1145.6963904565298;10071.546780394827;10353.79292414155;10359.067683908484;10367.533460994273;10379.792404151875;4217.725847819882;4278.101598664315;4313.482382114166;4326.762028088486;4333.111712099012;8677.305815534868;8680.305575554066;8723.563821809012;8728.432651877607;8756.693515726918;4787;4789.664723469324;4799.208130658472;4803.879903002383;4810.903781924342;4423;4441.511433742286;4445.888852778642;4458.4426946631675;4464.330350447394;3470.9652903471147;3476.5654293213347;3497.720182385403;3517.384457719889;3525.94711079334;1049.4123290956936;1060.9151267898549;1070.5985255529176;1086.4241951765578;1103.508938522366;1201.5434135028634;1203.9157258991786;1242.3353505874313;1436.8203974503188;1450.6518435575597;7595.5822429766895;7608.581528016012;7702.922970770221;7709.036370453693;7709.961450192825;1192.66605350502;1196.7726132034886;1200.5857978997233;1202.4108186988487;1204.8855358740905;6062.363451837494;6089.939100609025;6107.633541987495;6128.448439640454;6129.662868542273;9076.682316118904;9173.77065573366;9284.118008789153;9310.348275620641;9350;9154.542272886329;9157.175854173156;9224.077592240856;9234.122758337948;9253;7332.926670733331;7333.816654583678;7346.853062938818;7349.375303099189;7525.473216874876;7530.924690753022;7554.584497852671;7582.62086895664;7589.1272503662785;7597.240275972358;8195.098539160806;8257.504549727035;8392.4544904581;8418.326533877398;8424.157584241526;8546.273566746897;8710.085441028854;8804.075572064841;8838.690645827364;8844.955775221082;7216.603086830275;7273.563586184846;7300.671469783766;7317.817054573678;7321.597312147883;7787.883181752165;7815.29662330393;7815.882761758692;7849.568273744999;7866.646000930086;6369.49044076482;7388.224236455309;7396.408287337108;7438.404927605887;7500.624968751432;6027.397260274113;7154.427645788221;7276.4542659299705;7279.090113735783;7292.088488938883;7367.4106071515225;7368;7385.778426647209;7387.889181662172;7402.29678180572;6734.966325168343;6777.356151165632;6779.796606101825;6793.864122717617;6809.5233333666165;6787.694553744995;6824.385805277549;6883.518153729191;6893.620850853051;6931.861362772817 12:55:37 INFO - 2016-02-29 12:55:37,785 DEBUG : BROWSER_OUTPUT: |4;prototype.html;348.77678285897025;352.83945804658885;355.3266559869048;355.51472240391865;359.8398712572906;5996.190514280571;6065.787697430591;6068.69656517174;6074.848128796772;6121.265448146218;5720.856978575527;5818.301803783552;5893.44012318829;6002.759889604411;6018.39816018398;4642.5357464253475;4679.391679081715;4681.040386720714;4684.484706682262;4693.78877950493;4443.133588950156;4689.484156742756;4693.765311734417;4695.882602934937;4706.929396059062;4502.0545685406105;4528.25283828168;4603.539646035403;4650.0932318197965;4650.883787890899;4601.194790911611;4603.079384123189;4608.884777880547;4633.1660301145785;4635.745034023127;4092.774897380643;4096.446979657738;4096.877093687194;4100.118474527991;4103.138340948404;5624.971875140639;5696.914546281809;5705.058665320217;5707.1724599933195;5707.600467967244;5386.67679939201;5394.811181608664;5398.190271459273;5399.082156033483;5407.405185429599;6474.1907261592305;6476.902846457307;6481.384268494486;6488.0916671666;6488.351164883521;4497.7526236057;4504.504504504502;4505.324201369788;4512.842050528248;4519.661025423106;6568.474522038273;6617.669116544202;6690.598564086122;6691.565048271896;6693.531452798306;4571.771411429415;4577.816887324537;4578.748168850679;4579.885502862388;4584.17484852723;4628.930566041512;4634.281686338623;4634.328022436728;4635.258358662665;4639.095376401637;5349.786008559692;5350.678959262456;5358.6248962572245;5365.490278423544;5370.03339398912;6347.460465860454;6478.255000674889;6498.6425746583445;6498.837529061717;6499.155109835786;1633.8202797692245;1636.934522619082;1637.582416483789;1642.991785041067;1644.2272132097894;1085.4532291484602;1089.9128069754402;1092.2354351953663;1095.0910744082391;1105.5577768892508;6285.968570157212;6288.088227207121;6295.150154729145;6297.338779428185;6303.558750887486;6472.967635161794;6675.899861502081;6679.899801502981;6683.298253683391;6685.866282674417;6168;6213.2233470816145;6308.52686048539;6322.241331040213;6338.809835704937;3594.5866225383893;3618.131648404364;3622.4747411625167;3626.5829429615405;3629.8185090745355;6776.93223067763;6906.758263460755;6910.792676219721;6919.273476285019;6923.584584924921;6895.75864844728;6906.654667266717;6909.619970901648;6916.723331066802;6920.5847649141215;6877.931220687829;6902.827429314207;6907.758228461979;6911.6544172791155;6912.861742765116;6593.868122637617;6669.233038200475;6696.397324240842;6697.162854643169;6698.5980841149685;6651.035599838093;6652.667366631552;6656.667166641745;6666.26671066192;6668.499862510428;6885.690143943635;6893.620850853251;6902.516823822284;6903.1371078615175;6908.965455172692;4599.241125214436;4659.138059459011;4662.487126416024;4664.603508701798;4667.206574882211;6728.764493242713;6730.596164230162;6737.3599508046655;6742.550351674414;6745.5952642841585;6538.313477084837;6542.280349161683;6542.705578249085;6544.3782840630065;6561.639109849004;6448.355164483514;6500.284968653539;6539.574927629689;6542.574732642363;6543.803685889431;6413.166288382667;6418.775342862978;6424.903626445701;6435.967820160869;6437.549371543947;6556.2788093310655;6556.901646475402;6558.1802274715665;6564.704588293634;6572.14562106923;6323.336049714898;6395.360463953753;6400.42396184327;6406.455451286693;6417.614943103429 12:55:37 INFO - 2016-02-29 12:55:37,787 DEBUG : BROWSER_OUTPUT: |5;yui.html;910.9817803643925;921.8294615496134;931.4550987672211;931.6646007437317;935.3312381647122;14769.409223631068;14860.10839349637;14876.033057851231;14886.330115144818;14896.851031489696;13480.258585777778;15236.619084522892;15274.6945061099;15447.845521544781;15492.612684682861;731.8682637125315;889.715291106846;903.2051794420934;904.0191392339319;904.2494729374604;737.2774680812806;867.9609417576193;882.4264228251656;883.9204471597554;885.2608072259671;920.8526635738283;929.6281487405058;935.3312381647121;935.7005758157393;936.2369668720005;757.5530437042172;767.3592550220573;903.7650210945136;927.4110939553399;929.0523665860852;677.14003215916;678.1252184681755;678.2776343194482;679.5616827146512;679.5650783498564;14667;14699.338529766186;14703.70592588153;14721.705565888622;14798.40806367744;11954.282743035359;12769.55306564275;13130.409131589102;13173.538926137539;13576.524821631294;10976.835347469794;11221.719457013558;11503.59737409195;11559.364234967074;11688.123390745728;3856.5372155341256;3896.9415458767858;3921.1961547882615;3921.8039098044983;4009;46300.7684961573;46533.30200047002;47010.294845577;47353.76323118362;47382.28926566104;9682.322237443312;9837.360571562825;9966.202703783825;10445.84331235032;10465.47672616366;16841;16957.576060598338;16957.576060598585;17010;17164.82835171632;7838.137804841463;7922.643481043367;8017.118117007125;8144.511329320259;8469.66121355139;4580;4653.767311634472;4913.1893237616105;4925.901481970341;4991.775370108281;3181;3195.1053704962646;3197.6482586915886;3198.440272952224;3407.097119263397;618.5299172628835;635.6186288227027;636.9617822930546;637.4740838807909;646.0986923242145;622.0700053420076;649.7725795971467;663.8473151175257;688.1604442580044;688.3426327856885;8600.698975535826;8632.69785557515;8682;8757.211850933447;8959;624.4411251929498;640.0974625777632;721.1814590439889;742.5915746339492;744.9478536502393;4129.442525259052;4183.560726123774;4409.140217657526;4443.511213766483;4538.160440318552;61282.38717612767;61399.386006139364;61596;62357;62502.68748656318;52873.735631322364;53375.199372009454;53774.19338709922;53786.731066344415;55190.448095519336;47451;49273;49483.25775113376;49551.50448495469;49919.251211232586;9067.183953444222;9549.952250238704;9604.855927161238;9771.218302535637;9882.901170988485;36423.27153456863;37263.62736372602;38058.23883522259;38489.80755096207;38498.80750596229;43195.78402107969;46069.07861842812;46303.53696463127;46603.06793864172;46974.53025469701;10755.19336049815;10939.617113400993;11254.60608878718;11742.236754610924;12011.099167562294;13477.25875076841;13566.796498052734;13593.660158496117;13635.454581816617;13650.795238071636;12303.200291980993;12582.370881456074;12639.1784534005;12698.746025079632;13020.544280950122;11853.170278080452;12105.69735756578;12437.62687119388;12460.688482788002;12530.812037819258;9414.388064775767;11666.88333116658;12213.45039473208;12279.079069069678;12671.366431678563;10727.141828653534;10758.246922715334;10896.891031089588;11124.666260012213;11209.55161793519;10096.69709908704;10353.9482302588;10596.947015264874;10866.07638350749;10918.399488027917 12:55:37 INFO - 2016-02-29 12:55:37,787 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:55:37 INFO - 2016-02-29 12:55:37,787 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:55:37 INFO - 2016-02-29 12:55:37,787 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,935 12:55:37 INFO - 2016-02-29 12:55:37,787 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:55:37 INFO - 2016-02-29 12:55:37,787 DEBUG : BROWSER_OUTPUT: __startTimestamp1456779337778__endTimestamp 12:55:37 INFO - 2016-02-29 12:55:37,787 DEBUG : BROWSER_OUTPUT: 12:55:37 INFO - 2016-02-29 12:55:37,788 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:55:37 INFO - 2016-02-29 12:55:37,788 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:55:37 INFO - 2016-02-29 12:55:37,788 DEBUG : BROWSER_OUTPUT: 12:55:37 INFO - 2016-02-29 12:55:37,788 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5411.66 Median:5633.63 stddev:585.59 (10.4%) stddev-sans-first:562.10 12:55:37 INFO - 2016-02-29 12:55:37,789 DEBUG : BROWSER_OUTPUT: Values: 3241.7 3289.9 3314.9 3317.0 3334.4 5406.5 5418.8 5436.5 5452.9 5467.8 5396.2 5433.6 5457.1 5479.6 5480.9 4847.4 4920.4 4941.2 4986.1 5014.2 4976.8 4979.9 5038.5 5038.9 5043.3 4922.9 4992.5 5010.3 5028.7 5062.8 4966.2 5034.3 5037.2 5043.7 5063.5 4777.5 4954.7 4975.5 4995.0 5028.7 5169.3 5184.7 5193.0 5196.4 5206.7 5707.3 5730.1 5760.7 5763.1 5797.9 5695.9 5749.2 5755.2 5761.4 5791.3 5386.9 5409.3 5471.4 5476.8 5481.7 5916.9 5920.6 5922.3 5925.0 5925.3 5633.6 5741.0 5748.5 5754.3 5759.0 5780.7 5812.1 5816.0 5847.9 5848.3 5794.1 5819.0 5834.4 5835.6 5847.1 5631.7 5638.4 5837.9 5841.6 5841.7 4323.2 4362.5 4459.0 4468.0 4474.0 4025.5 4026.3 4028.4 4050.2 4055.4 5535.9 5538.9 5540.0 5540.0 5565.4 5654.5 5706.8 5814.2 5861.1 5933.5 5527.7 5563.7 5569.8 5571.8 5573.1 5054.2 5081.6 5092.2 5093.1 5119.8 5886.3 5894.7 5935.9 5993.2 5998.6 5841.0 5893.7 5895.1 5900.1 5906.7 5767.6 5955.1 5989.6 5997.4 6017.7 5684.4 5712.6 5738.1 5738.2 5772.1 5918.7 5947.3 5952.1 5955.6 5956.0 5573.2 5677.7 5768.1 5823.4 5827.6 5610.3 5676.2 5679.1 5680.9 5705.9 5638.8 5649.6 5652.4 5652.6 5657.3 5595.6 5660.1 5666.1 5720.5 5720.6 5616.3 5619.7 5627.3 5687.3 5710.3 12:55:37 INFO - 2016-02-29 12:55:37,789 DEBUG : BROWSER_OUTPUT: 12:55:37 INFO - 2016-02-29 12:55:37,789 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:55183.27 Median:20780.92 stddev:104055.70 (500.7%) stddev-sans-first:104266.81 12:55:37 INFO - 2016-02-29 12:55:37,789 DEBUG : BROWSER_OUTPUT: Values: 570.2 621.6 621.6 625.3 629.5 32315.2 33091.3 33125.8 33151.0 33165.2 33488.3 34022.5 41097.6 41250.8 41476.0 9024.6 9156.4 9158.3 9160.2 9201.4 8481.0 8972.7 9065.7 9069.9 9076.7 8434.6 10758.7 10982.9 10985.9 10989.3 10662.2 10742.7 10748.1 10758.1 10763.7 10565.2 10665.9 10684.4 10685.6 10691.4 42401.2 42694.1 42838.0 42863.0 42880.4 3656.3 3735.9 3746.8 3787.2 3817.8 30714.5 31030.2 31173.5 31236.5 31734.0 4266.1 4328.7 4357.1 4369.1 4379.7 286731.0 290300.0 290598.0 292053.0 293390.0 59695.4 60870.0 64538.4 64714.0 72454.3 65053.7 65066.0 65494.3 65494.7 65502.3 17691.5 17892.8 17927.5 17954.6 18001.7 13602.4 13695.8 13698.2 13756.8 13762.4 22068.8 22404.8 22408.3 22466.0 22535.0 7920.6 8118.6 8189.6 8189.8 8280.3 1040.4 1075.1 1116.9 1182.8 1206.6 29959.6 29998.6 30688.5 31029.2 31110.7 1088.3 1165.8 1192.6 1210.6 1241.6 13998.3 15661.9 15997.5 16005.8 16799.0 542199.0 558939.0 560511.0 560684.0 562183.0 58305.4 59479.4 59807.7 59919.4 59985.7 1434.5 1459.4 1465.2 1468.1 1482.8 31436.0 31578.8 31627.7 31933.2 32311.2 49954.0 50958.0 51020.5 51030.2 51103.2 254310.0 257287.0 257767.0 258214.0 258815.0 37139.0 44230.1 44260.6 44313.1 52786.9 50492.2 50692.5 51066.5 51504.7 51706.0 42159.6 42299.4 43200.6 43782.6 44104.0 42555.1 43813.0 44147.8 45541.0 48159.0 40883.0 41821.4 42447.8 42494.4 42558.4 37351.6 37815.0 41003.8 41339.6 41554.4 28139.7 28498.9 28648.6 28828.0 28943.1 12:55:37 INFO - 2016-02-29 12:55:37,790 DEBUG : BROWSER_OUTPUT: 12:55:37 INFO - 2016-02-29 12:55:37,790 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31021.90 Median:10646.15 stddev:98954.56 (929.5%) stddev-sans-first:99205.40 12:55:37 INFO - 2016-02-29 12:55:37,790 DEBUG : BROWSER_OUTPUT: Values: 379.1 380.0 382.3 384.2 385.3 14966.9 16372.4 17932.8 19583.6 19600.4 11636.4 12011.8 12012.2 19350.3 19667.9 5118.9 5243.0 5243.2 5243.8 5249.5 3980.6 4087.6 5202.5 5507.0 5666.2 5605.4 5626.0 5631.2 5653.0 5660.2 5486.8 5657.6 5661.2 5661.3 5665.6 5451.9 5460.2 5471.3 5477.7 5494.1 14190.9 14196.9 19857.4 19995.7 21412.0 2209.3 2237.1 2238.5 2244.2 2305.9 10223.9 10340.7 10342.3 10390.5 10924.6 1845.3 1931.9 1942.0 1972.2 2001.1 62238.7 65455.7 66155.7 66465.3 67730.7 10698.0 10892.5 11002.4 11004.2 11055.1 14176.4 14338.6 14344.4 14348.9 14356.3 8137.5 8194.4 8197.3 8244.0 8255.5 7686.4 7698.4 7735.6 7743.0 7757.3 4583.8 4648.9 4665.2 4676.3 4690.8 1752.0 1812.4 1855.6 1884.5 1904.5 888.7 963.4 977.4 1041.4 1050.5 15127.9 17588.6 17824.4 18019.2 18466.4 984.4 994.7 1015.1 1036.1 1065.4 10042.1 10220.1 10225.8 10329.7 10357.9 591795.0 598631.0 610712.0 610988.0 616937.0 80739.6 81336.6 82812.6 83357.0 84704.0 1120.4 1149.7 1151.0 1169.9 1188.0 15575.8 15713.8 15724.5 15725.4 15897.7 34366.8 34676.8 35092.3 35422.8 36092.0 43356.0 43364.6 43757.1 47552.8 52346.2 10343.6 10448.4 10629.2 10643.5 10665.0 12509.6 12537.1 12666.4 14241.5 16599.8 13391.2 15118.5 15203.2 15583.8 15643.8 14824.7 14865.4 15314.5 15330.6 15530.8 14848.6 15323.6 15414.8 15609.3 15812.0 10255.9 10502.6 10506.3 10515.6 10554.8 12765.2 14944.8 15082.0 15103.9 15495.5 12:55:37 INFO - 2016-02-29 12:55:37,790 DEBUG : BROWSER_OUTPUT: 12:55:37 INFO - 2016-02-29 12:55:37,790 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5534.87 Median:6249.58 stddev:2801.20 (44.8%) stddev-sans-first:2792.71 12:55:37 INFO - 2016-02-29 12:55:37,791 DEBUG : BROWSER_OUTPUT: Values: 1508.8 1510.5 1684.7 1816.3 1846.6 7525.8 7876.6 7880.4 7894.5 7895.4 6675.5 6761.5 7499.1 7681.5 7825.6 2302.5 2310.0 2337.8 2338.3 2339.0 2035.9 2340.4 2353.2 2421.5 2423.2 2026.6 2244.9 2340.0 2343.6 2344.0 2285.0 2321.9 2323.2 2363.6 2364.2 2319.0 2335.4 2343.0 2351.0 2366.2 7610.8 7661.5 7676.3 7677.1 7694.0 4640.8 4728.4 4728.7 4729.1 4731.7 3117.1 3171.2 3179.2 3180.8 3229.3 1066.1 1094.4 1102.6 1120.1 1145.7 10071.5 10353.8 10359.1 10367.5 10379.8 4217.7 4278.1 4313.5 4326.8 4333.1 8677.3 8680.3 8723.6 8728.4 8756.7 4787.0 4789.7 4799.2 4803.9 4810.9 4423.0 4441.5 4445.9 4458.4 4464.3 3471.0 3476.6 3497.7 3517.4 3525.9 1049.4 1060.9 1070.6 1086.4 1103.5 1201.5 1203.9 1242.3 1436.8 1450.7 7595.6 7608.6 7702.9 7709.0 7710.0 1192.7 1196.8 1200.6 1202.4 1204.9 6062.4 6089.9 6107.6 6128.4 6129.7 9076.7 9173.8 9284.1 9310.3 9350.0 9154.5 9157.2 9224.1 9234.1 9253.0 7332.9 7333.8 7346.9 7349.4 7525.5 7530.9 7554.6 7582.6 7589.1 7597.2 8195.1 8257.5 8392.5 8418.3 8424.2 8546.3 8710.1 8804.1 8838.7 8845.0 7216.6 7273.6 7300.7 7317.8 7321.6 7787.9 7815.3 7815.9 7849.6 7866.6 6369.5 7388.2 7396.4 7438.4 7500.6 6027.4 7154.4 7276.5 7279.1 7292.1 7367.4 7368.0 7385.8 7387.9 7402.3 6735.0 6777.4 6779.8 6793.9 6809.5 6787.7 6824.4 6883.5 6893.6 6931.9 12:55:37 INFO - 2016-02-29 12:55:37,791 DEBUG : BROWSER_OUTPUT: 12:55:37 INFO - 2016-02-29 12:55:37,792 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5416.84 Median:6190.61 stddev:1635.00 (26.4%) stddev-sans-first:1594.73 12:55:37 INFO - 2016-02-29 12:55:37,792 DEBUG : BROWSER_OUTPUT: Values: 348.8 352.8 355.3 355.5 359.8 5996.2 6065.8 6068.7 6074.8 6121.3 5720.9 5818.3 5893.4 6002.8 6018.4 4642.5 4679.4 4681.0 4684.5 4693.8 4443.1 4689.5 4693.8 4695.9 4706.9 4502.1 4528.3 4603.5 4650.1 4650.9 4601.2 4603.1 4608.9 4633.2 4635.7 4092.8 4096.4 4096.9 4100.1 4103.1 5625.0 5696.9 5705.1 5707.2 5707.6 5386.7 5394.8 5398.2 5399.1 5407.4 6474.2 6476.9 6481.4 6488.1 6488.4 4497.8 4504.5 4505.3 4512.8 4519.7 6568.5 6617.7 6690.6 6691.6 6693.5 4571.8 4577.8 4578.7 4579.9 4584.2 4628.9 4634.3 4634.3 4635.3 4639.1 5349.8 5350.7 5358.6 5365.5 5370.0 6347.5 6478.3 6498.6 6498.8 6499.2 1633.8 1636.9 1637.6 1643.0 1644.2 1085.5 1089.9 1092.2 1095.1 1105.6 6286.0 6288.1 6295.2 6297.3 6303.6 6473.0 6675.9 6679.9 6683.3 6685.9 6168.0 6213.2 6308.5 6322.2 6338.8 3594.6 3618.1 3622.5 3626.6 3629.8 6776.9 6906.8 6910.8 6919.3 6923.6 6895.8 6906.7 6909.6 6916.7 6920.6 6877.9 6902.8 6907.8 6911.7 6912.9 6593.9 6669.2 6696.4 6697.2 6698.6 6651.0 6652.7 6656.7 6666.3 6668.5 6885.7 6893.6 6902.5 6903.1 6909.0 4599.2 4659.1 4662.5 4664.6 4667.2 6728.8 6730.6 6737.4 6742.6 6745.6 6538.3 6542.3 6542.7 6544.4 6561.6 6448.4 6500.3 6539.6 6542.6 6543.8 6413.2 6418.8 6424.9 6436.0 6437.5 6556.3 6556.9 6558.2 6564.7 6572.1 6323.3 6395.4 6400.4 6406.5 6417.6 12:55:37 INFO - 2016-02-29 12:55:37,792 DEBUG : BROWSER_OUTPUT: 12:55:37 INFO - 2016-02-29 12:55:37,792 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14555.51 Median:25478.65 stddev:16616.26 (65.2%) stddev-sans-first:16631.28 12:55:37 INFO - 2016-02-29 12:55:37,792 DEBUG : BROWSER_OUTPUT: Values: 911.0 921.8 931.5 931.7 935.3 14769.4 14860.1 14876.0 14886.3 14896.9 13480.3 15236.6 15274.7 15447.8 15492.6 731.9 889.7 903.2 904.0 904.2 737.3 868.0 882.4 883.9 885.3 920.9 929.6 935.3 935.7 936.2 757.6 767.4 903.8 927.4 929.1 677.1 678.1 678.3 679.6 679.6 14667.0 14699.3 14703.7 14721.7 14798.4 11954.3 12769.6 13130.4 13173.5 13576.5 10976.8 11221.7 11503.6 11559.4 11688.1 3856.5 3896.9 3921.2 3921.8 4009.0 46300.8 46533.3 47010.3 47353.8 47382.3 9682.3 9837.4 9966.2 10445.8 10465.5 16841.0 16957.6 16957.6 17010.0 17164.8 7838.1 7922.6 8017.1 8144.5 8469.7 4580.0 4653.8 4913.2 4925.9 4991.8 3181.0 3195.1 3197.6 3198.4 3407.1 618.5 635.6 637.0 637.5 646.1 622.1 649.8 663.8 688.2 688.3 8600.7 8632.7 8682.0 8757.2 8959.0 624.4 640.1 721.2 742.6 744.9 4129.4 4183.6 4409.1 4443.5 4538.2 61282.4 61399.4 61596.0 62357.0 62502.7 52873.7 53375.2 53774.2 53786.7 55190.4 47451.0 49273.0 49483.3 49551.5 49919.3 9067.2 9550.0 9604.9 9771.2 9882.9 36423.3 37263.6 38058.2 38489.8 38498.8 43195.8 46069.1 46303.5 46603.1 46974.5 10755.2 10939.6 11254.6 11742.2 12011.1 13477.3 13566.8 13593.7 13635.5 13650.8 12303.2 12582.4 12639.2 12698.7 13020.5 11853.2 12105.7 12437.6 12460.7 12530.8 9414.4 11666.9 12213.5 12279.1 12671.4 10727.1 10758.2 10896.9 11124.7 11209.6 10096.7 10353.9 10596.9 10866.1 10918.4 12:55:37 INFO - 2016-02-29 12:55:37,792 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:55:37 INFO - 2016-02-29 12:55:37,792 DEBUG : BROWSER_OUTPUT: 12:55:38 INFO - 2016-02-29 12:55:38,429 INFO : Browser exited with error code: 0 12:55:38 INFO - 2016-02-29 12:55:38,450 INFO : Completed test dromaeo_css (00:18:30) 12:55:38 INFO - 2016-02-29 12:55:38,450 INFO : Starting test kraken 12:55:38 INFO - 2016-02-29 12:55:38,451 DEBUG : operating with platform_type : linux_ 12:55:38 INFO - 2016-02-29 12:55:38,451 INFO : Initialising browser for kraken test... 12:55:38 INFO - 2016-02-29 12:55:38,457 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXy73Pk/profile http://localhost:33544/getInfo.html 12:55:42 INFO - 2016-02-29 12:55:42,443 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:55:42 INFO - 2016-02-29 12:55:42,443 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:55:42 INFO - 2016-02-29 12:55:42,443 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:55:42 INFO - 2016-02-29 12:55:42,443 DEBUG : BROWSER_OUTPUT: __metrics 12:55:42 INFO - 2016-02-29 12:55:42,585 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:55:43 INFO - 2016-02-29 12:55:43,573 INFO : Browser initialized. 12:55:43 INFO - 2016-02-29 12:55:43,574 INFO : Running cycle 1/1 for kraken test... 12:55:43 INFO - 2016-02-29 12:55:43,574 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXy73Pk/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:55:55 INFO - 2016-02-29 12:55:55,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 134336512 12:55:55 INFO - 2016-02-29 12:55:55,301 DEBUG : BROWSER_OUTPUT: 12:55:57 INFO - 2016-02-29 12:55:57,717 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33544/tests/kraken/driver.html?testName=audio-beat-detection) 12:55:58 INFO - 2016-02-29 12:55:58,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 164204544 12:55:58 INFO - 2016-02-29 12:55:58,300 DEBUG : BROWSER_OUTPUT: 12:56:00 INFO - 2016-02-29 12:56:00,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33544/tests/kraken/driver.html?testName=audio-dft) 12:56:01 INFO - 2016-02-29 12:56:01,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 162463744 12:56:01 INFO - 2016-02-29 12:56:01,410 DEBUG : BROWSER_OUTPUT: 12:56:04 INFO - 2016-02-29 12:56:04,208 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33544/tests/kraken/driver.html?testName=audio-fft) 12:56:04 INFO - 2016-02-29 12:56:04,771 DEBUG : BROWSER_OUTPUT: RSS: Main: 160792576 12:56:04 INFO - 2016-02-29 12:56:04,772 DEBUG : BROWSER_OUTPUT: 12:56:06 INFO - 2016-02-29 12:56:06,731 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33544/tests/kraken/driver.html?testName=audio-oscillator) 12:56:07 INFO - 2016-02-29 12:56:07,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 159174656 12:56:07 INFO - 2016-02-29 12:56:07,305 DEBUG : BROWSER_OUTPUT: 12:56:09 INFO - 2016-02-29 12:56:09,480 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33544/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:56:10 INFO - 2016-02-29 12:56:10,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 159432704 12:56:10 INFO - 2016-02-29 12:56:10,052 DEBUG : BROWSER_OUTPUT: 12:56:12 INFO - 2016-02-29 12:56:12,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33544/tests/kraken/driver.html?testName=imaging-darkroom) 12:56:13 INFO - 2016-02-29 12:56:13,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 157708288 12:56:13 INFO - 2016-02-29 12:56:13,438 DEBUG : BROWSER_OUTPUT: 12:56:16 INFO - 2016-02-29 12:56:16,768 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33544/tests/kraken/driver.html?testName=imaging-desaturate) 12:56:17 INFO - 2016-02-29 12:56:17,334 DEBUG : BROWSER_OUTPUT: RSS: Main: 159154176 12:56:17 INFO - 2016-02-29 12:56:17,334 DEBUG : BROWSER_OUTPUT: 12:56:20 INFO - 2016-02-29 12:56:20,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33544/tests/kraken/driver.html?testName=json-parse-financial) 12:56:20 INFO - 2016-02-29 12:56:20,621 DEBUG : BROWSER_OUTPUT: RSS: Main: 159453184 12:56:20 INFO - 2016-02-29 12:56:20,621 DEBUG : BROWSER_OUTPUT: 12:56:22 INFO - 2016-02-29 12:56:22,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33544/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:56:22 INFO - 2016-02-29 12:56:22,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 165511168 12:56:22 INFO - 2016-02-29 12:56:22,684 DEBUG : BROWSER_OUTPUT: 12:56:24 INFO - 2016-02-29 12:56:24,475 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33544/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:56:25 INFO - 2016-02-29 12:56:25,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 161828864 12:56:25 INFO - 2016-02-29 12:56:25,063 DEBUG : BROWSER_OUTPUT: 12:56:27 INFO - 2016-02-29 12:56:27,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33544/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:56:27 INFO - 2016-02-29 12:56:27,597 DEBUG : BROWSER_OUTPUT: RSS: Main: 168386560 12:56:27 INFO - 2016-02-29 12:56:27,597 DEBUG : BROWSER_OUTPUT: 12:56:29 INFO - 2016-02-29 12:56:29,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:56:30 INFO - 2016-02-29 12:56:30,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 175886336 12:56:30 INFO - 2016-02-29 12:56:30,554 DEBUG : BROWSER_OUTPUT: 12:56:33 INFO - 2016-02-29 12:56:33,020 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:56:33 INFO - 2016-02-29 12:56:33,590 DEBUG : BROWSER_OUTPUT: RSS: Main: 172564480 12:56:33 INFO - 2016-02-29 12:56:33,590 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33544/tests/kraken/driver.html?testName=ai-astar) 12:56:35 INFO - 2016-02-29 12:56:35,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 231075840 12:56:35 INFO - 2016-02-29 12:56:35,486 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,486 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:56:35 INFO - 2016-02-29 12:56:35,486 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:56:35 INFO - 2016-02-29 12:56:35,487 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:56:35 INFO - 2016-02-29 12:56:35,487 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:56:35 INFO - 2016-02-29 12:56:35,487 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;109;105;109;110;109;100;109;108;109 12:56:35 INFO - 2016-02-29 12:56:35,487 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;123;159;155;124;145;145;120;163;122 12:56:35 INFO - 2016-02-29 12:56:35,488 DEBUG : BROWSER_OUTPUT: |2;audio-dft;159;159;161;159;160;160;160;164;158;160 12:56:35 INFO - 2016-02-29 12:56:35,488 DEBUG : BROWSER_OUTPUT: |3;audio-fft;71;71;72;156;71;72;72;73;150;72 12:56:35 INFO - 2016-02-29 12:56:35,488 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;136;92;93;92;134;92;92;132 12:56:35 INFO - 2016-02-29 12:56:35,488 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;109;109;110;109;110 12:56:35 INFO - 2016-02-29 12:56:35,489 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;145;145;145;145;145;146;145;145;146;146 12:56:35 INFO - 2016-02-29 12:56:35,489 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;95;95;95;96 12:56:35 INFO - 2016-02-29 12:56:35,489 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;55;55;56;55;55;55;57;55;54;53 12:56:35 INFO - 2016-02-29 12:56:35,490 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;65;66;65;77;65;64;65;68 12:56:35 INFO - 2016-02-29 12:56:35,490 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;77;77;76;78;79;77;77;78;77;78 12:56:35 INFO - 2016-02-29 12:56:35,490 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;117;116;110;125;120;116;114;115;108 12:56:35 INFO - 2016-02-29 12:56:35,490 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;152;138;143;139;139;145;137;139;137;129 12:56:35 INFO - 2016-02-29 12:56:35,491 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;66;64;62;65;64;64;62;65;63;63 12:56:35 INFO - 2016-02-29 12:56:35,491 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:56:35 INFO - 2016-02-29 12:56:35,491 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:56:35 INFO - 2016-02-29 12:56:35,491 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,907 12:56:35 INFO - 2016-02-29 12:56:35,492 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:56:35 INFO - 2016-02-29 12:56:35,492 DEBUG : BROWSER_OUTPUT: __startTimestamp1456779395480__endTimestamp 12:56:35 INFO - 2016-02-29 12:56:35,492 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,493 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:56:35 INFO - 2016-02-29 12:56:35,493 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:56:35 INFO - 2016-02-29 12:56:35,493 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,493 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:107.70 Median:109.00 stddev:3.02 (2.8%) stddev-sans-first:3.17 12:56:35 INFO - 2016-02-29 12:56:35,493 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 105.0 109.0 110.0 109.0 100.0 109.0 108.0 109.0 12:56:35 INFO - 2016-02-29 12:56:35,493 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,494 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:140.50 Median:147.00 stddev:16.71 (11.4%) stddev-sans-first:17.44 12:56:35 INFO - 2016-02-29 12:56:35,494 DEBUG : BROWSER_OUTPUT: Values: 149.0 123.0 159.0 155.0 124.0 145.0 145.0 120.0 163.0 122.0 12:56:35 INFO - 2016-02-29 12:56:35,494 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,494 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.00 Median:160.00 stddev:1.63 (1.0%) stddev-sans-first:1.69 12:56:35 INFO - 2016-02-29 12:56:35,494 DEBUG : BROWSER_OUTPUT: Values: 159.0 159.0 161.0 159.0 160.0 160.0 160.0 164.0 158.0 160.0 12:56:35 INFO - 2016-02-29 12:56:35,494 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,494 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:88.00 Median:72.00 stddev:34.29 (47.6%) stddev-sans-first:35.82 12:56:35 INFO - 2016-02-29 12:56:35,495 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 72.0 156.0 71.0 72.0 72.0 73.0 150.0 72.0 12:56:35 INFO - 2016-02-29 12:56:35,495 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,495 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.80 Median:92.00 stddev:20.18 (21.9%) stddev-sans-first:20.94 12:56:35 INFO - 2016-02-29 12:56:35,495 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 136.0 92.0 93.0 92.0 134.0 92.0 92.0 132.0 12:56:35 INFO - 2016-02-29 12:56:35,495 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,496 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:56:35 INFO - 2016-02-29 12:56:35,497 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 109.0 109.0 110.0 109.0 110.0 12:56:35 INFO - 2016-02-29 12:56:35,497 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,497 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:145.30 Median:145.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 12:56:35 INFO - 2016-02-29 12:56:35,497 DEBUG : BROWSER_OUTPUT: Values: 145.0 145.0 145.0 145.0 145.0 146.0 145.0 145.0 146.0 146.0 12:56:35 INFO - 2016-02-29 12:56:35,497 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,497 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 12:56:35 INFO - 2016-02-29 12:56:35,497 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 12:56:35 INFO - 2016-02-29 12:56:35,497 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,497 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.05 (1.9%) stddev-sans-first:1.12 12:56:35 INFO - 2016-02-29 12:56:35,498 DEBUG : BROWSER_OUTPUT: Values: 55.0 55.0 56.0 55.0 55.0 55.0 57.0 55.0 54.0 53.0 12:56:35 INFO - 2016-02-29 12:56:35,498 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,498 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:65.00 stddev:3.84 (5.9%) stddev-sans-first:4.03 12:56:35 INFO - 2016-02-29 12:56:35,498 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 65.0 66.0 65.0 77.0 65.0 64.0 65.0 68.0 12:56:35 INFO - 2016-02-29 12:56:35,498 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,498 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:77.40 Median:77.50 stddev:0.84 (1.1%) stddev-sans-first:0.88 12:56:35 INFO - 2016-02-29 12:56:35,498 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 76.0 78.0 79.0 77.0 77.0 78.0 77.0 78.0 12:56:35 INFO - 2016-02-29 12:56:35,498 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,498 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:115.40 Median:116.00 stddev:4.81 (4.1%) stddev-sans-first:5.02 12:56:35 INFO - 2016-02-29 12:56:35,499 DEBUG : BROWSER_OUTPUT: Values: 113.0 117.0 116.0 110.0 125.0 120.0 116.0 114.0 115.0 108.0 12:56:35 INFO - 2016-02-29 12:56:35,499 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,499 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:139.80 Median:139.00 stddev:6.00 (4.3%) stddev-sans-first:4.45 12:56:35 INFO - 2016-02-29 12:56:35,499 DEBUG : BROWSER_OUTPUT: Values: 152.0 138.0 143.0 139.0 139.0 145.0 137.0 139.0 137.0 129.0 12:56:35 INFO - 2016-02-29 12:56:35,499 DEBUG : BROWSER_OUTPUT: 12:56:35 INFO - 2016-02-29 12:56:35,499 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:64.00 stddev:1.32 (2.1%) stddev-sans-first:1.13 12:56:35 INFO - 2016-02-29 12:56:35,499 DEBUG : BROWSER_OUTPUT: Values: 66.0 64.0 62.0 65.0 64.0 64.0 62.0 65.0 63.0 63.0 12:56:35 INFO - 2016-02-29 12:56:35,499 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:56:35 INFO - 2016-02-29 12:56:35,499 DEBUG : BROWSER_OUTPUT: 12:56:36 INFO - 2016-02-29 12:56:36,165 INFO : Browser exited with error code: 0 12:56:36 INFO - 2016-02-29 12:56:36,216 INFO : Completed test kraken (00:00:57) 12:56:36 INFO - 2016-02-29 12:56:36,216 INFO : Starting test v8_7 12:56:36 INFO - 2016-02-29 12:56:36,216 DEBUG : operating with platform_type : linux_ 12:56:36 INFO - 2016-02-29 12:56:36,217 INFO : Initialising browser for v8_7 test... 12:56:36 INFO - 2016-02-29 12:56:36,223 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAKopfJ/profile http://localhost:33544/getInfo.html 12:56:39 INFO - 2016-02-29 12:56:39,958 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:56:39 INFO - 2016-02-29 12:56:39,958 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:56:39 INFO - 2016-02-29 12:56:39,958 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:56:39 INFO - 2016-02-29 12:56:39,958 DEBUG : BROWSER_OUTPUT: __metrics 12:56:40 INFO - 2016-02-29 12:56:40,095 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:56:41 INFO - 2016-02-29 12:56:41,197 INFO : Browser initialized. 12:56:41 INFO - 2016-02-29 12:56:41,198 INFO : Running cycle 1/1 for v8_7 test... 12:56:41 INFO - 2016-02-29 12:56:41,198 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpAKopfJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:56:52 INFO - 2016-02-29 12:56:52,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 134381568 12:56:52 INFO - 2016-02-29 12:56:52,863 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:33544/tests/v8_7/run.html (next: http://localhost:33544/tests/v8_7/run.html) 12:57:14 INFO - 2016-02-29 12:57:14,446 DEBUG : BROWSER_OUTPUT: RSS: Main: 424173568 12:57:14 INFO - 2016-02-29 12:57:14,446 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,447 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:57:14 INFO - 2016-02-29 12:57:14,448 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:57:14 INFO - 2016-02-29 12:57:14,448 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:57:14 INFO - 2016-02-29 12:57:14,448 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:57:14 INFO - 2016-02-29 12:57:14,448 DEBUG : BROWSER_OUTPUT: |0;Richards;168.20857863751053 12:57:14 INFO - 2016-02-29 12:57:14,448 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;165.20733520568314 12:57:14 INFO - 2016-02-29 12:57:14,448 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 12:57:14 INFO - 2016-02-29 12:57:14,448 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5143.589743589743 12:57:14 INFO - 2016-02-29 12:57:14,449 DEBUG : BROWSER_OUTPUT: |4;RayTrace;970.8737864077669 12:57:14 INFO - 2016-02-29 12:57:14,449 DEBUG : BROWSER_OUTPUT: |5;Earley;547.0459518599563 12:57:14 INFO - 2016-02-29 12:57:14,449 DEBUG : BROWSER_OUTPUT: |6;Boyer;10557.894736842105 12:57:14 INFO - 2016-02-29 12:57:14,449 DEBUG : BROWSER_OUTPUT: |7;RegExp;24166.666666666668 12:57:14 INFO - 2016-02-29 12:57:14,449 DEBUG : BROWSER_OUTPUT: |8;Splay;524.1090146750524 12:57:14 INFO - 2016-02-29 12:57:14,449 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 12:57:14 INFO - 2016-02-29 12:57:14,450 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:57:14 INFO - 2016-02-29 12:57:14,450 DEBUG : BROWSER_OUTPUT: __startTimestamp1456779434446__endTimestamp 12:57:14 INFO - 2016-02-29 12:57:14,450 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,450 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:57:14 INFO - 2016-02-29 12:57:14,450 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:57:14 INFO - 2016-02-29 12:57:14,450 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,451 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:168.21 Median:168.21 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,451 DEBUG : BROWSER_OUTPUT: Values: 168.2 12:57:14 INFO - 2016-02-29 12:57:14,451 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,451 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:165.21 Median:165.21 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,451 DEBUG : BROWSER_OUTPUT: Values: 165.2 12:57:14 INFO - 2016-02-29 12:57:14,453 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,453 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,453 DEBUG : BROWSER_OUTPUT: Values: 278.0 12:57:14 INFO - 2016-02-29 12:57:14,453 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,453 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5143.59 Median:5143.59 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,453 DEBUG : BROWSER_OUTPUT: Values: 5143.6 12:57:14 INFO - 2016-02-29 12:57:14,453 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,454 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:970.87 Median:970.87 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,454 DEBUG : BROWSER_OUTPUT: Values: 970.9 12:57:14 INFO - 2016-02-29 12:57:14,454 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,454 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:547.05 Median:547.05 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,454 DEBUG : BROWSER_OUTPUT: Values: 547.0 12:57:14 INFO - 2016-02-29 12:57:14,454 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,454 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:10557.89 Median:10557.89 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,455 DEBUG : BROWSER_OUTPUT: Values: 10557.9 12:57:14 INFO - 2016-02-29 12:57:14,455 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,455 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24166.67 Median:24166.67 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,455 DEBUG : BROWSER_OUTPUT: Values: 24166.7 12:57:14 INFO - 2016-02-29 12:57:14,455 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,455 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:524.11 Median:524.11 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,455 DEBUG : BROWSER_OUTPUT: Values: 524.1 12:57:14 INFO - 2016-02-29 12:57:14,455 DEBUG : BROWSER_OUTPUT: 12:57:14 INFO - 2016-02-29 12:57:14,456 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 12:57:14 INFO - 2016-02-29 12:57:14,456 DEBUG : BROWSER_OUTPUT: Values: 4830.9 12:57:14 INFO - 2016-02-29 12:57:14,456 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:57:14 INFO - 2016-02-29 12:57:14,456 DEBUG : BROWSER_OUTPUT: 12:57:15 INFO - 2016-02-29 12:57:15,125 INFO : Browser exited with error code: 0 12:57:15 INFO - 2016-02-29 12:57:15,142 INFO : Completed test v8_7 (00:00:38) 12:57:15 INFO - 2016-02-29 12:57:15,506 INFO : Completed test suite (00:20:07) 12:57:15 INFO - 2016-02-29 12:57:15,507 DEBUG : Working with test: dromaeo_css 12:57:15 INFO - 2016-02-29 12:57:15,507 DEBUG : Generating results file: dromaeo_css 12:57:15 INFO - 2016-02-29 12:57:15,508 DEBUG : Working with test: kraken 12:57:15 INFO - 2016-02-29 12:57:15,508 DEBUG : Generating results file: kraken 12:57:15 INFO - 2016-02-29 12:57:15,508 INFO : javascript benchmark 12:57:15 INFO - 2016-02-29 12:57:15,508 DEBUG : Working with test: v8_7 12:57:15 INFO - 2016-02-29 12:57:15,509 DEBUG : Generating results file: v8_7 12:57:15 INFO - 2016-02-29 12:57:15,509 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:57:15 INFO - 2016-02-29 12:57:15,565 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,53,35]] 12:57:15 INFO - 2016-02-29 12:57:15,565 DEBUG : process_Request line: dromaeo_css 7320.88 graph.html#tests=[[72,53,35]] 12:57:15 INFO - 2016-02-29 12:57:15,565 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:57:15 INFO - 2016-02-29 12:57:15,595 DEBUG : process_Request line: kraken 1468.70 graph.html#tests=[[232,53,35]] 12:57:15 INFO - 2016-02-29 12:57:15,595 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:57:15 INFO - 2016-02-29 12:57:15,627 DEBUG : process_Request line: v8_7 23223.31 graph.html#tests=[[230,53,35]] 12:57:15 INFO - 2016-02-29 12:57:15,629 INFO : javascript benchmark 12:57:15 INFO - 2016-02-29 12:57:15,632 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3241.708246257837, 3289.8684052637896, 3314.8839790607317, 3316.9834150829242, 3334.433146365118, 5406.513413792758, 5418.83743487695, 5436.510714035736, 5452.890942181149, 5467.753951072202, 5396.217548455472, 5433.6196466247375, 5457.072297709389, 5479.643823151492, 5480.862978425542, 4847.394075740533, 4920.434150072751, 4941.160002799524, 4986.127427700156, 5014.172661510846, 4976.800927962877, 4979.875503112433, 5038.546530812227, 5038.874028149307, 5043.344365232515, 4922.8523144305545, 4992.450830408652, 5010.348654674905, 5028.748562571856, 5062.772175252123, 4966.15575352191, 5034.320366750479, 5037.168867136918, 5043.697378157322, 5063.518965698253, 4777.498362671904, 4954.7274899880495, 4975.527324904128, 4995.0, 5028.723420211887, 5169.276301317818, 5184.688918664892, 5193.039287731744, 5196.350456192976, 5206.739663016834, 5707.34365547959, 5730.05454100073, 5760.683162426065, 5763.1355296705415, 5797.884042319172, 5695.943040569583, 5749.195112684228, 5755.22304488897, 5761.423857614247, 5791.333996590404, 5386.91919621206, 5409.29679141709, 5471.398146203915, 5476.835694929118, 5481.671099734029, 5916.852078697981, 5920.5559583031445, 5922.318933322723, 5924.970375148183, 5925.318588362307, 5633.63381380209, 5740.971295143581, 5748.48263656273, 5754.338251101093, 5759.0, 5780.653160810365, 5812.070068789058, 5815.9709201453725, 5847.853803654858, 5848.3274423441, 5794.072948328248, 5818.970905145447, 5834.416558344132, 5835.591508594358, 5847.06446968483, 5631.746571404296, 5638.379778224392, 5837.854053648608, 5841.591088623755, 5841.678707671034, 4323.200207961537, 4362.541933097043, 4459.0413061192, 4467.950031742538, 4473.977630111829, 4025.4766880305374, 4026.255142798533, 4028.436018957348, 4050.23045621331, 4055.3511438169753, 5535.944640553543, 5538.9169162461785, 5540.0, 5540.0, 5565.41563135873, 5654.462826031603, 5706.771729130788, 5814.215080964101, 5861.120831875252, 5933.495652869468, 5527.668339899619, 5563.749631266603, 5569.805056823073, 5571.832845014656, 5573.080441727069, 5054.166062599704, 5081.644284900021, 5092.236164575269, 5093.083245015932, 5119.846404607868, 5886.3230728465915, 5894.67579283135, 5935.881282374328, 5993.190919225936, 5998.640081595118, 5840.970795145997, 5893.734781934738, 5895.056790913433, 5900.055991041584, 5906.70466476683, 5767.5674324425, 5955.076963070731, 5989.64062156272, 5997.400259973968, 6017.669028203491, 5684.3747187808485, 5712.6001179917, 5738.110592858114, 5738.1679656450415, 5772.105323674838, 5918.73365698536, 5947.316058653138, 5952.107183922446, 5955.642661440327, 5955.970220148872, 5573.247611572548, 5677.7161141941915, 5768.134779783066, 5823.417658234142, 5827.59206855516, 5610.298712660918, 5676.2337084493065, 5679.091345384719, 5680.886382272414, 5705.885882282414, 5638.774449021993, 5649.604527683187, 5652.434756524314, 5652.63257888236, 5657.2928383952, 5595.552355811444, 5660.094384898396, 5666.065099258741, 5720.542356611378, 5720.570957178312, 5616.297962754656, 5619.747111379916, 5627.324721033502, 5687.317521897398, 5710.2576665033275], "unit": "ms", "name": "dojo.html", "value": 5374.592078494827}, {"lowerIsBetter": false, "replicates": [570.2131059138388, 621.6208113051038, 621.6363427394974, 625.2559454249446, 629.4712441549098, 32315.192120197007, 33091.33817323655, 33125.834370828175, 33151.0, 33165.170870728245, 33488.330233395376, 34022.48966265502, 41097.589024109824, 41250.79374603123, 41476.0, 9024.639014439415, 9156.359054866161, 9158.313126515504, 9160.17558419742, 9201.401908875901, 8481.0, 8972.685955991541, 9065.728028159167, 9069.909300907006, 9076.727698169032, 8434.62044208012, 10758.731031724192, 10982.945085274603, 10985.945070274638, 10989.285696429746, 10662.200334974868, 10742.731431714192, 10748.086412654933, 10758.139348852073, 10763.677089687322, 10565.207609429246, 10665.946670266676, 10684.35893846364, 10685.626003089932, 10691.411972341519, 42401.151976960595, 42694.146117077486, 42838.0, 42863.0, 42880.35679464779, 3656.2687462507606, 3735.8505659773577, 3746.83139258734, 3787.1857550626473, 3817.790021548814, 30714.53928191079, 31030.224244393845, 31173.532397013838, 31236.531452028237, 31734.0, 4266.082792199661, 4328.653707703376, 4357.085012147453, 4369.104333611602, 4379.671524635633, 286731.0, 290300.0, 290598.0, 292053.0, 293390.0, 59695.403045969855, 60870.0, 64538.35461645323, 64714.0, 72454.2754572458, 65053.67473162604, 65066.02400963989, 65494.345056548824, 65494.67252663706, 65502.34497655058, 17691.469255922344, 17892.821071789374, 17927.462176134737, 17954.5511362217, 18001.7299740504, 13602.387892544859, 13695.794563081561, 13698.178109313472, 13756.793648095287, 13762.380692868845, 22068.779312206992, 22404.775952240594, 22408.327750167522, 22466.0, 22535.0, 7920.6039698014865, 8118.594070296462, 8189.590520473953, 8189.795255118551, 8280.337572994145, 1040.401768982838, 1075.0539525217757, 1116.8603924509437, 1182.7930112230497, 1206.6138835572533, 29959.550606740915, 29998.550021749692, 30688.53967190494, 31029.224269392995, 31110.68889311078, 1088.3252383522108, 1165.7642898527588, 1192.5587532612988, 1210.6186551236333, 1241.5592464675092, 13998.300084995913, 15661.921690391475, 15997.520074397788, 16005.791438785864, 16798.992060476165, 542199.0, 558939.0, 560511.0, 560684.0, 562183.0, 58305.416945830846, 59479.40520594825, 59807.70096149491, 59919.400805992256, 59985.70007149936, 1434.454907135282, 1459.4162335065846, 1465.1794994802945, 1468.0677769616157, 1482.7627579587215, 31436.0, 31578.842105789325, 31627.683723162474, 31933.20166995844, 32311.192220194684, 49954.0, 50958.0, 51020.48979510306, 51030.23454648258, 51103.233451499, 254310.0, 257287.0, 257767.0, 258214.0, 258815.0, 37139.0, 44230.11539769251, 44260.55739442565, 44313.11373772571, 52786.94426111533, 50492.24261636005, 50692.49307506878, 51066.48933510766, 51504.74247628738, 51706.0, 42159.578404215565, 42299.365509518, 43200.56799431965, 43782.56217437785, 44104.0, 42555.14889702127, 43813.0, 44147.77926110349, 45541.0, 48159.03681926272, 40882.962519039414, 41821.37267940922, 42447.787761060994, 42494.36258456187, 42558.36162457504, 37351.626483735905, 37815.0, 41003.794981024905, 41339.586604133576, 41554.437128249825, 28139.700783709126, 28498.857505712338, 28648.570271446362, 28828.0, 28943.13170604885], "unit": "ms", "name": "ext.html", "value": 20711.83855019187}, {"lowerIsBetter": false, "replicates": [379.1072025380231, 379.96580307772297, 382.2584186677845, 384.2085304273197, 385.339143369122, 14966.850331496682, 16372.426965056226, 17932.820671793277, 19583.608327833434, 19600.411987640357, 11636.360000200008, 12011.819822702644, 12012.219205751642, 19350.322738704148, 19667.901660491676, 5118.872028199296, 5243.003829272445, 5243.2135179723155, 5243.79024839006, 5249.501297376743, 3980.6417422431973, 4087.57080506547, 5202.453742357055, 5507.008738427082, 5666.150077488369, 5605.439456054382, 5626.043572592669, 5631.18347839563, 5653.0, 5660.2075709400515, 5486.835394938158, 5657.632253903483, 5661.207430959669, 5661.320641523023, 5665.603407761479, 5451.918221226685, 5460.208269800856, 5471.288732464794, 5477.698726570037, 5494.120940649477, 14190.935679823951, 14196.858031419657, 19857.404277871687, 19995.70027948193, 21412.036458359413, 2209.3151123151874, 2237.0604346174646, 2238.473958619723, 2244.16965722682, 2305.9077636894503, 10223.897761022368, 10340.689779306633, 10342.276040677156, 10390.48047597617, 10924.563017479291, 1845.308009496439, 1931.9130639121133, 1941.9708704369305, 1972.2209727157835, 2001.1395100106947, 62238.68880655613, 65455.67272163656, 66155.66922165359, 66465.3353466464, 67730.66134669345, 10698.0, 10892.509837057352, 11002.394868282321, 11004.174686898514, 11055.06031987274, 14176.432942682177, 14338.56984290473, 14344.354504047344, 14348.928255358865, 14356.282185890665, 8137.511749295061, 8194.426390152632, 8197.303229225583, 8243.95878020618, 8255.504669719836, 7686.385089192851, 7698.42261830365, 7735.61321933901, 7743.0, 7757.26306000929, 4583.793729282191, 4648.86053418398, 4665.160271151225, 4676.3453116563705, 4690.81236750533, 1752.0190023752969, 1812.3928483958023, 1855.6010457751647, 1884.5100273928877, 1904.495308743184, 888.7022847346083, 963.4363897120263, 977.3549457358109, 1041.4063983529468, 1050.5220124843179, 15127.924360378127, 17588.560285992953, 17824.3761468348, 18019.18913648889, 18466.446006619823, 984.4487087231173, 994.6817018553993, 1015.1371334365878, 1036.0727149201423, 1065.350136416785, 10042.14641755459, 10220.131288840532, 10225.795484090277, 10329.741756455998, 10357.896421035693, 591795.0, 598631.0, 610712.0, 610988.0, 616937.0, 80739.59630201811, 81336.59331703304, 82812.58593706993, 83357.0, 84704.0, 1120.4229821641861, 1149.655103468956, 1150.9827352589718, 1169.906407487399, 1187.9524819007142, 15575.766363504783, 15713.842861571238, 15724.528264152093, 15725.44960926362, 15897.68204635924, 34366.82816585901, 34676.82661586676, 35092.298154037286, 35422.822885885405, 36092.0, 43356.0, 43364.56635433605, 43757.12485750331, 47552.762236189985, 52346.21480677869, 10343.586256549654, 10448.373097614167, 10629.20280978945, 10643.521041553304, 10665.0, 12509.56216532417, 12537.122401432178, 12666.366681665695, 14241.50154744579, 16599.83400165983, 13391.196528208338, 15118.546443606709, 15203.163825989677, 15583.766243506583, 15643.765343520085, 14824.703505930036, 14865.405383784528, 15314.540563782659, 15330.616734581725, 15530.844691553391, 14848.62878428048, 15323.61690957735, 15414.768778468557, 15609.297581608627, 15812.0, 10255.897441025494, 10502.632407865687, 10506.317089389166, 10515.631952881613, 10554.788904222027, 12765.170263932814, 14944.775828362366, 15082.0, 15103.924480377527, 15495.535133946], "unit": "ms", "name": "jquery.html", "value": 9156.186407466595}, {"lowerIsBetter": false, "replicates": [1508.8491150884909, 1510.4939845151873, 1684.6883326584582, 1816.320926633217, 1846.5845184833406, 7525.774226773192, 7876.5667888266125, 7880.369570434365, 7894.526328420299, 7895.40784441167, 6675.532712710112, 6761.459083273338, 7499.062617172854, 7681.462297639167, 7825.608719564013, 2302.5279817637343, 2310.0, 2337.754535773745, 2338.286822519131, 2338.976610233893, 2035.8880261585607, 2340.426595484109, 2353.2469609724894, 2421.4793819328843, 2423.200343886513, 2026.564288677934, 2244.9438764030865, 2339.9883000584973, 2343.6015877300815, 2344.0, 2284.9543009139807, 2321.8839058047115, 2323.2217207235594, 2363.61000434928, 2364.243442098529, 2319.0, 2335.3927978725656, 2342.9648555271515, 2350.9647355289685, 2366.1718398560365, 7610.8477830443635, 7661.46770645873, 7676.347510461617, 7677.11713152989, 7694.0, 4640.837570685044, 4728.40894888139, 4728.66899317048, 4729.125111854318, 4731.668783185179, 3117.0804612639326, 3171.2389026633673, 3179.205198700325, 3180.793248438844, 3229.337985712923, 1066.1311031509372, 1094.3652681444744, 1102.5920409448556, 1120.1207052463776, 1145.6963904565298, 10071.546780394827, 10353.79292414155, 10359.067683908484, 10367.533460994273, 10379.792404151875, 4217.725847819882, 4278.101598664315, 4313.482382114166, 4326.762028088486, 4333.111712099012, 8677.305815534868, 8680.305575554066, 8723.563821809012, 8728.432651877607, 8756.693515726918, 4787.0, 4789.664723469324, 4799.208130658472, 4803.879903002383, 4810.903781924342, 4423.0, 4441.511433742286, 4445.888852778642, 4458.4426946631675, 4464.330350447394, 3470.9652903471147, 3476.5654293213347, 3497.720182385403, 3517.384457719889, 3525.94711079334, 1049.4123290956936, 1060.9151267898549, 1070.5985255529176, 1086.4241951765578, 1103.508938522366, 1201.5434135028634, 1203.9157258991786, 1242.3353505874313, 1436.8203974503188, 1450.6518435575597, 7595.5822429766895, 7608.581528016012, 7702.922970770221, 7709.036370453693, 7709.961450192825, 1192.66605350502, 1196.7726132034886, 1200.5857978997233, 1202.4108186988487, 1204.8855358740905, 6062.363451837494, 6089.939100609025, 6107.633541987495, 6128.448439640454, 6129.662868542273, 9076.682316118904, 9173.77065573366, 9284.118008789153, 9310.348275620641, 9350.0, 9154.542272886329, 9157.175854173156, 9224.077592240856, 9234.122758337948, 9253.0, 7332.926670733331, 7333.816654583678, 7346.853062938818, 7349.375303099189, 7525.473216874876, 7530.924690753022, 7554.584497852671, 7582.62086895664, 7589.1272503662785, 7597.240275972358, 8195.098539160806, 8257.504549727035, 8392.4544904581, 8418.326533877398, 8424.157584241526, 8546.273566746897, 8710.085441028854, 8804.075572064841, 8838.690645827364, 8844.955775221082, 7216.603086830275, 7273.563586184846, 7300.671469783766, 7317.817054573678, 7321.597312147883, 7787.883181752165, 7815.29662330393, 7815.882761758692, 7849.568273744999, 7866.646000930086, 6369.49044076482, 7388.224236455309, 7396.408287337108, 7438.404927605887, 7500.624968751432, 6027.397260274113, 7154.427645788221, 7276.4542659299705, 7279.090113735783, 7292.088488938883, 7367.4106071515225, 7368.0, 7385.778426647209, 7387.889181662172, 7402.29678180572, 6734.966325168343, 6777.356151165632, 6779.796606101825, 6793.864122717617, 6809.5233333666165, 6787.694553744995, 6824.385805277549, 6883.518153729191, 6893.620850853051, 6931.861362772817], "unit": "ms", "name": "mootools.html", "value": 4581.699540585517}, {"lowerIsBetter": false, "replicates": [348.77678285897025, 352.83945804658885, 355.3266559869048, 355.51472240391865, 359.8398712572906, 5996.190514280571, 6065.787697430591, 6068.69656517174, 6074.848128796772, 6121.265448146218, 5720.856978575527, 5818.301803783552, 5893.44012318829, 6002.759889604411, 6018.39816018398, 4642.5357464253475, 4679.391679081715, 4681.040386720714, 4684.484706682262, 4693.78877950493, 4443.133588950156, 4689.484156742756, 4693.765311734417, 4695.882602934937, 4706.929396059062, 4502.0545685406105, 4528.25283828168, 4603.539646035403, 4650.0932318197965, 4650.883787890899, 4601.194790911611, 4603.079384123189, 4608.884777880547, 4633.1660301145785, 4635.745034023127, 4092.774897380643, 4096.446979657738, 4096.877093687194, 4100.118474527991, 4103.138340948404, 5624.971875140639, 5696.914546281809, 5705.058665320217, 5707.1724599933195, 5707.600467967244, 5386.67679939201, 5394.811181608664, 5398.190271459273, 5399.082156033483, 5407.405185429599, 6474.1907261592305, 6476.902846457307, 6481.384268494486, 6488.0916671666, 6488.351164883521, 4497.7526236057, 4504.504504504502, 4505.324201369788, 4512.842050528248, 4519.661025423106, 6568.474522038273, 6617.669116544202, 6690.598564086122, 6691.565048271896, 6693.531452798306, 4571.771411429415, 4577.816887324537, 4578.748168850679, 4579.885502862388, 4584.17484852723, 4628.930566041512, 4634.281686338623, 4634.328022436728, 4635.258358662665, 4639.095376401637, 5349.786008559692, 5350.678959262456, 5358.6248962572245, 5365.490278423544, 5370.03339398912, 6347.460465860454, 6478.255000674889, 6498.6425746583445, 6498.837529061717, 6499.155109835786, 1633.8202797692245, 1636.934522619082, 1637.582416483789, 1642.991785041067, 1644.2272132097894, 1085.4532291484602, 1089.9128069754402, 1092.2354351953663, 1095.0910744082391, 1105.5577768892508, 6285.968570157212, 6288.088227207121, 6295.150154729145, 6297.338779428185, 6303.558750887486, 6472.967635161794, 6675.899861502081, 6679.899801502981, 6683.298253683391, 6685.866282674417, 6168.0, 6213.2233470816145, 6308.52686048539, 6322.241331040213, 6338.809835704937, 3594.5866225383893, 3618.131648404364, 3622.4747411625167, 3626.5829429615405, 3629.8185090745355, 6776.93223067763, 6906.758263460755, 6910.792676219721, 6919.273476285019, 6923.584584924921, 6895.75864844728, 6906.654667266717, 6909.619970901648, 6916.723331066802, 6920.5847649141215, 6877.931220687829, 6902.827429314207, 6907.758228461979, 6911.6544172791155, 6912.861742765116, 6593.868122637617, 6669.233038200475, 6696.397324240842, 6697.162854643169, 6698.5980841149685, 6651.035599838093, 6652.667366631552, 6656.667166641745, 6666.26671066192, 6668.499862510428, 6885.690143943635, 6893.620850853251, 6902.516823822284, 6903.1371078615175, 6908.965455172692, 4599.241125214436, 4659.138059459011, 4662.487126416024, 4664.603508701798, 4667.206574882211, 6728.764493242713, 6730.596164230162, 6737.3599508046655, 6742.550351674414, 6745.5952642841585, 6538.313477084837, 6542.280349161683, 6542.705578249085, 6544.3782840630065, 6561.639109849004, 6448.355164483514, 6500.284968653539, 6539.574927629689, 6542.574732642363, 6543.803685889431, 6413.166288382667, 6418.775342862978, 6424.903626445701, 6435.967820160869, 6437.549371543947, 6556.2788093310655, 6556.901646475402, 6558.1802274715665, 6564.704588293634, 6572.14562106923, 6323.336049714898, 6395.360463953753, 6400.42396184327, 6406.455451286693, 6417.614943103429], "unit": "ms", "name": "prototype.html", "value": 4888.645212484976}, {"lowerIsBetter": false, "replicates": [910.9817803643925, 921.8294615496134, 931.4550987672211, 931.6646007437317, 935.3312381647122, 14769.409223631068, 14860.10839349637, 14876.033057851231, 14886.330115144818, 14896.851031489696, 13480.258585777778, 15236.619084522892, 15274.6945061099, 15447.845521544781, 15492.612684682861, 731.8682637125315, 889.715291106846, 903.2051794420934, 904.0191392339319, 904.2494729374604, 737.2774680812806, 867.9609417576193, 882.4264228251656, 883.9204471597554, 885.2608072259671, 920.8526635738283, 929.6281487405058, 935.3312381647121, 935.7005758157393, 936.2369668720005, 757.5530437042172, 767.3592550220573, 903.7650210945136, 927.4110939553399, 929.0523665860852, 677.14003215916, 678.1252184681755, 678.2776343194482, 679.5616827146512, 679.5650783498564, 14667.0, 14699.338529766186, 14703.70592588153, 14721.705565888622, 14798.40806367744, 11954.282743035359, 12769.55306564275, 13130.409131589102, 13173.538926137539, 13576.524821631294, 10976.835347469794, 11221.719457013558, 11503.59737409195, 11559.364234967074, 11688.123390745728, 3856.5372155341256, 3896.9415458767858, 3921.1961547882615, 3921.8039098044983, 4009.0, 46300.7684961573, 46533.30200047002, 47010.294845577, 47353.76323118362, 47382.28926566104, 9682.322237443312, 9837.360571562825, 9966.202703783825, 10445.84331235032, 10465.47672616366, 16841.0, 16957.576060598338, 16957.576060598585, 17010.0, 17164.82835171632, 7838.137804841463, 7922.643481043367, 8017.118117007125, 8144.511329320259, 8469.66121355139, 4580.0, 4653.767311634472, 4913.1893237616105, 4925.901481970341, 4991.775370108281, 3181.0, 3195.1053704962646, 3197.6482586915886, 3198.440272952224, 3407.097119263397, 618.5299172628835, 635.6186288227027, 636.9617822930546, 637.4740838807909, 646.0986923242145, 622.0700053420076, 649.7725795971467, 663.8473151175257, 688.1604442580044, 688.3426327856885, 8600.698975535826, 8632.69785557515, 8682.0, 8757.211850933447, 8959.0, 624.4411251929498, 640.0974625777632, 721.1814590439889, 742.5915746339492, 744.9478536502393, 4129.442525259052, 4183.560726123774, 4409.140217657526, 4443.511213766483, 4538.160440318552, 61282.38717612767, 61399.386006139364, 61596.0, 62357.0, 62502.68748656318, 52873.735631322364, 53375.199372009454, 53774.19338709922, 53786.731066344415, 55190.448095519336, 47451.0, 49273.0, 49483.25775113376, 49551.50448495469, 49919.251211232586, 9067.183953444222, 9549.952250238704, 9604.855927161238, 9771.218302535637, 9882.901170988485, 36423.27153456863, 37263.62736372602, 38058.23883522259, 38489.80755096207, 38498.80750596229, 43195.78402107969, 46069.07861842812, 46303.53696463127, 46603.06793864172, 46974.53025469701, 10755.19336049815, 10939.617113400993, 11254.60608878718, 11742.236754610924, 12011.099167562294, 13477.25875076841, 13566.796498052734, 13593.660158496117, 13635.454581816617, 13650.795238071636, 12303.200291980993, 12582.370881456074, 12639.1784534005, 12698.746025079632, 13020.544280950122, 11853.170278080452, 12105.69735756578, 12437.62687119388, 12460.688482788002, 12530.812037819258, 9414.388064775767, 11666.88333116658, 12213.45039473208, 12279.079069069678, 12671.366431678563, 10727.141828653534, 10758.246922715334, 10896.891031089588, 11124.666260012213, 11209.55161793519, 10096.69709908704, 10353.9482302588, 10596.947015264874, 10866.07638350749, 10918.399488027917], "unit": "ms", "name": "yui.html", "value": 6742.861307596315}], "name": "dromaeo_css", "value": 7320.87916195256}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 109.0, 105.0, 109.0, 110.0, 109.0, 100.0, 109.0, 108.0, 109.0], "unit": "ms", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [149.0, 123.0, 159.0, 155.0, 124.0, 145.0, 145.0, 120.0, 163.0, 122.0], "unit": "ms", "name": "audio-beat-detection", "value": 140.5}, {"lowerIsBetter": true, "replicates": [159.0, 159.0, 161.0, 159.0, 160.0, 160.0, 160.0, 164.0, 158.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 160.0}, {"lowerIsBetter": true, "replicates": [71.0, 71.0, 72.0, 156.0, 71.0, 72.0, 72.0, 73.0, 150.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 88.0}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 136.0, 92.0, 93.0, 92.0, 134.0, 92.0, 92.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 104.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0, 145.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 145.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 55.0, 57.0, 55.0, 54.0, 53.0], "unit": "ms", "name": "json-parse-financial", "value": 55.0}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 66.0, 65.0, 77.0, 65.0, 64.0, 65.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 66.5}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 76.0, 78.0, 79.0, 77.0, 77.0, 78.0, 77.0, 78.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 77.4}, {"lowerIsBetter": true, "replicates": [113.0, 117.0, 116.0, 110.0, 125.0, 120.0, 116.0, 114.0, 115.0, 108.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 115.4}, {"lowerIsBetter": true, "replicates": [152.0, 138.0, 143.0, 139.0, 139.0, 145.0, 137.0, 139.0, 137.0, 129.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 139.8}, {"lowerIsBetter": true, "replicates": [66.0, 64.0, 62.0, 65.0, 64.0, 64.0, 62.0, 65.0, 63.0, 63.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 63.8}], "name": "kraken", "value": 1468.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [168.20857863751053], "unit": "score", "name": "Richards", "value": 209.87038999999996}, {"lowerIsBetter": false, "replicates": [165.20733520568314], "unit": "score", "name": "DeltaBlue", "value": 400.2122539999999}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5143.589743589743], "unit": "score", "name": "Decrypt", "value": 51.75004486540379}, {"lowerIsBetter": false, "replicates": [970.8737864077669], "unit": "score", "name": "RayTrace", "value": 762.18867}, {"lowerIsBetter": false, "replicates": [547.0459518599563], "unit": "score", "name": "Earley", "value": 1218.294364}, {"lowerIsBetter": false, "replicates": [10557.894736842105], "unit": "score", "name": "Boyer", "value": 63.12461116650046}, {"lowerIsBetter": false, "replicates": [24166.666666666668], "unit": "score", "name": "RegExp", "value": 37.69593103448274}, {"lowerIsBetter": false, "replicates": [524.1090146750524], "unit": "score", "name": "Splay", "value": 155.48482799999994}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 23223.310593287682}]} 12:57:15 INFO - RETURN: dromaeo_css: 7320.88 12:57:15 INFO - RETURN: kraken: 1468.70 12:57:15 INFO - RETURN: v8_7: 23223.31 12:57:15 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,35]]", "result": "23223.31"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,35]]", "result": "1468.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,35]]", "result": "7320.88"}}} 12:57:15 INFO - Return code: 0 12:57:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 12:57:15 INFO - # TBPL SUCCESS # 12:57:15 INFO - Running post-action listener: _resource_record_post_action 12:57:15 INFO - Running post-run listener: _resource_record_post_run 12:57:16 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 315392; Write bytes: 358260736; Read time: 60; Write time: 327148 12:57:16 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 99467264; Read time: 0; Write time: 99076 12:57:16 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 315392; Write bytes: 258162688; Read time: 60; Write time: 228048 12:57:16 INFO - Running post-run listener: _upload_blobber_files 12:57:16 INFO - Blob upload gear active. 12:57:16 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:57:16 INFO - Copying logs to upload dir... 12:57:16 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1321.271285 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 1 secs) (at 2016-02-29 12:57:15.677309) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-29 12:57:15.680613) ========= 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=836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009877 build_url: 'https://queue.taskcluster.net/v1/task/ct_FpM6oQkui1EKf1m1zzQ/artifacts/public/build/firefox-45.0.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-02-29 12:57:15.732559) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:57:15.732911) ========= 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=836cfdc75598d54cb747368e000001a9-1456778113.829974-1579531922 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004536 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-29 12:57:15.786094) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 12:57:15.786863) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-29 12:57:15.787577) ========= ========= Total master_lag: 0.26 =========