builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-016 starttime: 1453717395.61 results: success (0) buildid: 20160125001712 builduid: 5d8eb007e2de4c2eae63c4ce4fd78a1e revision: ab89c814f1b8a841168de98ac2679a1d66122a06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.612568) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.613054) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.613420) ========= 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=00204705a9daa57ed339a427000001b9-1453712460.489241-876706828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006334 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.641651) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.642012) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.666119) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.666452) ========= 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=00204705a9daa57ed339a427000001b9-1453712460.489241-876706828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004604 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.715701) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.716058) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.716472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.716829) ========= 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=00204705a9daa57ed339a427000001b9-1453712460.489241-876706828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 02:23:16-- 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% 60.3M=0s 2016-01-25 02:23:16 (60.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.100480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.833131) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.833582) ========= 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=00204705a9daa57ed339a427000001b9-1453712460.489241-876706828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020361 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.886005) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:15.886607) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab89c814f1b8a841168de98ac2679a1d66122a06 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ab89c814f1b8a841168de98ac2679a1d66122a06 --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=00204705a9daa57ed339a427000001b9-1453712460.489241-876706828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 02:23:16,287 truncating revision to first 12 chars 2016-01-25 02:23:16,287 Setting DEBUG logging. 2016-01-25 02:23:16,287 attempt 1/10 2016-01-25 02:23:16,287 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ab89c814f1b8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-25 02:23:16,574 unpacking tar archive at: mozilla-aurora-ab89c814f1b8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.626835 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:16.527315) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:16.527772) ========= echo ab89c814f1b8a841168de98ac2679a1d66122a06 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'ab89c814f1b8a841168de98ac2679a1d66122a06'] 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=00204705a9daa57ed339a427000001b9-1453712460.489241-876706828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ab89c814f1b8a841168de98ac2679a1d66122a06 program finished with exit code 0 elapsedTime=0.004365 script_repo_revision: 'ab89c814f1b8a841168de98ac2679a1d66122a06' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:16.581613) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:16.581951) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 02:23:16.599349) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-25 02:23:16.599732) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1453712460.489241-876706828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:23:17 INFO - MultiFileLogger online at 20160125 02:23:17 in /builds/slave/test-pgo 02:23:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:23:17 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 02:23:17 INFO - {'append_to_log': False, 02:23:17 INFO - 'base_work_dir': '/builds/slave/test-pgo', 02:23:17 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:23:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 02:23:17 INFO - 'branch': 'Mozilla-Aurora', 02:23:17 INFO - 'buildbot_json_path': 'buildprops.json', 02:23:17 INFO - 'config_files': ('talos/linux_config.py',), 02:23:17 INFO - 'default_actions': ('clobber', 02:23:17 INFO - 'read-buildbot-config', 02:23:17 INFO - 'download-and-extract', 02:23:17 INFO - 'populate-webroot', 02:23:17 INFO - 'create-virtualenv', 02:23:17 INFO - 'install', 02:23:17 INFO - 'run-tests'), 02:23:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:23:17 INFO - 'download_minidump_stackwalk': True, 02:23:17 INFO - 'download_symbols': 'ondemand', 02:23:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:23:17 INFO - 'tooltool.py': '/tools/tooltool.py', 02:23:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:23:17 INFO - '/tools/misc-python/virtualenv.py')}, 02:23:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:23:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:23:17 INFO - 'installer_path': 'installer.exe', 02:23:17 INFO - 'log_level': 'info', 02:23:17 INFO - 'log_name': 'talos', 02:23:17 INFO - 'log_to_console': True, 02:23:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:23:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:23:17 INFO - 'opt_config_files': (), 02:23:17 INFO - 'pip_index': False, 02:23:17 INFO - 'sps_profile': False, 02:23:17 INFO - 'sps_profile_interval': 0, 02:23:17 INFO - 'suite': 'dromaeojs-e10s', 02:23:17 INFO - 'system_bits': '32', 02:23:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:23:17 INFO - 'title': 'talos-linux64-ix-016', 02:23:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:23:17 INFO - 'use_talos_json': True, 02:23:17 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 02:23:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:23:17 INFO - 'work_dir': 'build'} 02:23:17 INFO - ##### 02:23:17 INFO - ##### Running clobber step. 02:23:17 INFO - ##### 02:23:17 INFO - Running pre-action listener: _resource_record_pre_action 02:23:17 INFO - Running main action method: clobber 02:23:17 INFO - rmtree: /builds/slave/test-pgo/build 02:23:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 02:23:17 INFO - Running post-action listener: _resource_record_post_action 02:23:17 INFO - ##### 02:23:17 INFO - ##### Running read-buildbot-config step. 02:23:17 INFO - ##### 02:23:17 INFO - Running pre-action listener: _resource_record_pre_action 02:23:17 INFO - Running main action method: read_buildbot_config 02:23:17 INFO - Using buildbot properties: 02:23:17 INFO - { 02:23:17 INFO - "properties": { 02:23:17 INFO - "buildnumber": 12, 02:23:17 INFO - "product": "firefox", 02:23:17 INFO - "script_repo_revision": "production", 02:23:17 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:23:17 INFO - "repository": "", 02:23:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:23:17 INFO - "buildid": "20160125001712", 02:23:17 INFO - "slavename": "talos-linux64-ix-016", 02:23:17 INFO - "pgo_build": "True", 02:23:17 INFO - "basedir": "/builds/slave/test-pgo", 02:23:17 INFO - "project": "", 02:23:17 INFO - "platform": "ubuntu64_hw", 02:23:17 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:23:17 INFO - "slavebuilddir": "test", 02:23:17 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:23:17 INFO - "branch": "mozilla-aurora", 02:23:17 INFO - "repo_path": "releases/mozilla-aurora", 02:23:17 INFO - "stage_platform": "linux64-pgo", 02:23:17 INFO - "builduid": "5d8eb007e2de4c2eae63c4ce4fd78a1e", 02:23:17 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 02:23:17 INFO - }, 02:23:17 INFO - "sourcestamp": { 02:23:17 INFO - "repository": "", 02:23:17 INFO - "hasPatch": false, 02:23:17 INFO - "project": "", 02:23:17 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 02:23:17 INFO - "changes": [ 02:23:17 INFO - { 02:23:17 INFO - "category": null, 02:23:17 INFO - "files": [ 02:23:17 INFO - { 02:23:17 INFO - "url": null, 02:23:17 INFO - "name": "https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 02:23:17 INFO - } 02:23:17 INFO - ], 02:23:17 INFO - "repository": "", 02:23:17 INFO - "rev": "ab89c814f1b8a841168de98ac2679a1d66122a06", 02:23:17 INFO - "who": "cbook@mozilla.com", 02:23:17 INFO - "when": 1453717351, 02:23:17 INFO - "number": 7510169, 02:23:17 INFO - "comments": "Bug 1241061 - [firefox-ui-tests] Workaround for bug 1237706 to use ZipFile if unzip command is not available. r=maja_zf, a=test-only", 02:23:17 INFO - "project": "", 02:23:17 INFO - "at": "Mon 25 Jan 2016 02:22:31", 02:23:17 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 02:23:17 INFO - "revlink": "", 02:23:17 INFO - "properties": [ 02:23:17 INFO - [ 02:23:17 INFO - "buildid", 02:23:17 INFO - "20160125001712", 02:23:17 INFO - "Change" 02:23:17 INFO - ], 02:23:17 INFO - [ 02:23:17 INFO - "builduid", 02:23:17 INFO - "5d8eb007e2de4c2eae63c4ce4fd78a1e", 02:23:17 INFO - "Change" 02:23:17 INFO - ], 02:23:17 INFO - [ 02:23:17 INFO - "pgo_build", 02:23:17 INFO - "True", 02:23:17 INFO - "Change" 02:23:17 INFO - ] 02:23:17 INFO - ], 02:23:17 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 02:23:17 INFO - } 02:23:17 INFO - ], 02:23:17 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 02:23:17 INFO - } 02:23:17 INFO - } 02:23:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 02:23:17 INFO - Running post-action listener: _resource_record_post_action 02:23:17 INFO - ##### 02:23:17 INFO - ##### Running download-and-extract step. 02:23:17 INFO - ##### 02:23:17 INFO - Running pre-action listener: _resource_record_pre_action 02:23:17 INFO - Running main action method: download_and_extract 02:23:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 02:23: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')]} 02:23:17 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 02:23:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 02:23:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 02:23:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 02:23:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 02:23:23 INFO - Downloaded 1302 bytes. 02:23:23 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 02:23:23 INFO - Using the following test package requirements: 02:23:23 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 02:23:23 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:23 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:23:23 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:23 INFO - u'jsshell-linux-x86_64.zip'], 02:23:23 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:23 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:23:23 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 02:23:23 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:23 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:23:23 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:23 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:23:23 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:23 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:23:23 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 02:23:23 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 02:23:23 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:23:23 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:23: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')]} 02:23:23 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:23:24 INFO - Downloaded 23159167 bytes. 02:23:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 02:23:24 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:23:25 INFO - Return code: 0 02:23:25 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:23:25 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')]} 02:23:25 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:23:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:23:35 INFO - Downloaded 23159167 bytes. 02:23:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test-pgo/build/tests 02:23:35 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 02:23:35 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 02:23:36 INFO - Return code: 0 02:23: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')]} 02:23:36 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:23:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:23:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:23:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:23:37 INFO - Downloaded 11132038 bytes. 02:23:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test-pgo/build/tests 02:23:37 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 02:23:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 02:23:37 INFO - Return code: 0 02:23:37 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')]} 02:23:37 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:23:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:23:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:23:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:23:38 INFO - Downloaded 58033452 bytes. 02:23:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:23:38 INFO - mkdir: /builds/slave/test-pgo/properties 02:23:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 02:23:38 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 02:23:38 INFO - Contents: 02:23:38 INFO - build_url:https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 02:23:38 INFO - Running post-action listener: _resource_record_post_action 02:23:38 INFO - Running post-action listener: set_extra_try_arguments 02:23:38 INFO - ##### 02:23:38 INFO - ##### Running populate-webroot step. 02:23:38 INFO - ##### 02:23:38 INFO - Running pre-action listener: _resource_record_pre_action 02:23:38 INFO - Running main action method: populate_webroot 02:23:38 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:23:38 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:23:38 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:23:38 INFO - '--tppagecycles', 02:23:38 INFO - '7'], 02:23:38 INFO - 'tests': ['tsvgm']}}, 02:23:38 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 02:23:38 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 02:23:38 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:23:38 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:23:38 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 02:23:38 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 02:23:38 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:38 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:38 INFO - 'talos_options': ['--e10s'], 02:23:38 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:23:38 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:38 INFO - 'tests': ['damp', 'tps']}, 02:23:38 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:38 INFO - 'talos_options': ['--e10s'], 02:23:38 INFO - 'tests': ['damp', 'tps']}, 02:23:38 INFO - 'g3': {'tests': ['dromaeo_dom']}, 02:23:38 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:23:38 INFO - 'other': {'tests': ['a11yr', 02:23:38 INFO - 'ts_paint', 02:23:38 INFO - 'tpaint', 02:23:38 INFO - 'sessionrestore', 02:23:38 INFO - 'sessionrestore_no_auto_restore']}, 02:23:38 INFO - 'other-e10s': {'talos_options': ['--e10s'], 02:23:38 INFO - 'tests': ['a11yr', 02:23:38 INFO - 'ts_paint', 02:23:38 INFO - 'tpaint', 02:23:38 INFO - 'sessionrestore', 02:23:38 INFO - 'sessionrestore_no_auto_restore']}, 02:23:38 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 02:23:38 INFO - 'tests': ['a11yr', 02:23:38 INFO - 'ts_paint', 02:23:38 INFO - 'tpaint', 02:23:38 INFO - 'sessionrestore', 02:23:38 INFO - 'sessionrestore_no_auto_restore']}, 02:23:38 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 02:23:38 INFO - 'tests': ['a11yr', 02:23:38 INFO - 'ts_paint', 02:23:38 INFO - 'tpaint', 02:23:38 INFO - 'sessionrestore', 02:23:38 INFO - 'sessionrestore_no_auto_restore']}, 02:23:38 INFO - 'other_l64': {'tests': ['a11yr', 02:23:38 INFO - 'ts_paint', 02:23:38 INFO - 'tpaint', 02:23:38 INFO - 'sessionrestore', 02:23:38 INFO - 'sessionrestore_no_auto_restore']}, 02:23:38 INFO - 'other_nol64': {'tests': ['a11yr', 02:23:38 INFO - 'ts_paint', 02:23:38 INFO - 'tpaint', 02:23:38 INFO - 'sessionrestore', 02:23:38 INFO - 'sessionrestore_no_auto_restore']}, 02:23:38 INFO - 'svgr': {'tests': ['tsvgx', 02:23:38 INFO - 'tsvgr_opacity', 02:23:38 INFO - 'tart', 02:23:38 INFO - 'tscrollx', 02:23:38 INFO - 'cart']}, 02:23:38 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 02:23:38 INFO - 'tests': ['tsvgx', 02:23:38 INFO - 'tsvgr_opacity', 02:23:38 INFO - 'tart', 02:23:38 INFO - 'tscrollx', 02:23:38 INFO - 'cart']}, 02:23:38 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:38 INFO - 'tests': ['tp5o']}, 02:23:38 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:38 INFO - 'talos_options': ['--e10s'], 02:23:38 INFO - 'tests': ['tp5o']}, 02:23:38 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:38 INFO - 'talos_options': ['--xperf_path', 02:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:38 INFO - 'tests': ['tp5n']}, 02:23:38 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:23:38 INFO - 'talos_options': ['--e10s', 02:23:38 INFO - '--xperf_path', 02:23:38 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:23:38 INFO - 'tests': ['tp5n']}}, 02:23:38 INFO - 'talos.zip': {'path': '', 02:23:38 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:23:38 INFO - Running post-action listener: _resource_record_post_action 02:23:38 INFO - ##### 02:23:38 INFO - ##### Running create-virtualenv step. 02:23:38 INFO - ##### 02:23:38 INFO - Running pre-action listener: _resource_record_pre_action 02:23:38 INFO - Running main action method: create_virtualenv 02:23:38 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 02:23:38 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 02:23:38 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 02:23:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:23:39 INFO - Using real prefix '/usr' 02:23:39 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 02:23:39 INFO - Installing distribute.............................................................................................................................................................................................done. 02:23:41 INFO - Installing pip.................done. 02:23:41 INFO - Return code: 0 02:23:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 02:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:41 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 0x7f97f2166f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, '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': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', '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 02:23:41 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 02:23:41 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 02:23:41 INFO - Using env: {'DISPLAY': ':0', 02:23:41 INFO - 'HOME': '/home/cltbld', 02:23:41 INFO - 'LANG': 'en_US.UTF-8', 02:23:41 INFO - 'LANGUAGE': 'en_US:en', 02:23:41 INFO - 'LOGNAME': 'cltbld', 02:23:41 INFO - 'MAIL': '/var/mail/cltbld', 02:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:41 INFO - 'MOZ_NO_REMOTE': '1', 02:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:41 INFO - 'NO_EM_RESTART': '1', 02:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:41 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:41 INFO - 'SHELL': '/bin/bash', 02:23:41 INFO - 'SHLVL': '1', 02:23:41 INFO - 'TERM': 'linux', 02:23:41 INFO - 'TMOUT': '86400', 02:23:41 INFO - 'USER': 'cltbld', 02:23:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:41 INFO - '_': '/tools/buildbot/bin/python'} 02:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:41 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 02:23:41 INFO - Cleaning up... 02:23:41 INFO - Return code: 0 02:23:41 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 02:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:41 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 0x7f97f2166f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, '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': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', '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 02:23:41 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 02:23:41 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 02:23:41 INFO - Using env: {'DISPLAY': ':0', 02:23:41 INFO - 'HOME': '/home/cltbld', 02:23:41 INFO - 'LANG': 'en_US.UTF-8', 02:23:41 INFO - 'LANGUAGE': 'en_US:en', 02:23:41 INFO - 'LOGNAME': 'cltbld', 02:23:41 INFO - 'MAIL': '/var/mail/cltbld', 02:23:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:41 INFO - 'MOZ_NO_REMOTE': '1', 02:23:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:41 INFO - 'NO_EM_RESTART': '1', 02:23:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:41 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:41 INFO - 'SHELL': '/bin/bash', 02:23:41 INFO - 'SHLVL': '1', 02:23:41 INFO - 'TERM': 'linux', 02:23:41 INFO - 'TMOUT': '86400', 02:23:41 INFO - 'USER': 'cltbld', 02:23:41 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:23:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:41 INFO - '_': '/tools/buildbot/bin/python'} 02:23:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:42 INFO - Downloading/unpacking psutil>=0.7.1 02:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:43 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 02:23:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:43 INFO - Installing collected packages: psutil 02:23:43 INFO - Running setup.py install for psutil 02:23:43 INFO - building 'psutil._psutil_linux' extension 02:23:43 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 02:23:44 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 02:23:44 INFO - building 'psutil._psutil_posix' extension 02:23:44 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 02:23:44 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 02:23:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:23:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:23:44 INFO - Successfully installed psutil 02:23:44 INFO - Cleaning up... 02:23:44 INFO - Return code: 0 02:23:44 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 02:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:44 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 0x7f97f2166f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, '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': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', '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 02:23:44 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 02:23:44 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 02:23:44 INFO - Using env: {'DISPLAY': ':0', 02:23:44 INFO - 'HOME': '/home/cltbld', 02:23:44 INFO - 'LANG': 'en_US.UTF-8', 02:23:44 INFO - 'LANGUAGE': 'en_US:en', 02:23:44 INFO - 'LOGNAME': 'cltbld', 02:23:44 INFO - 'MAIL': '/var/mail/cltbld', 02:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:44 INFO - 'MOZ_NO_REMOTE': '1', 02:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:44 INFO - 'NO_EM_RESTART': '1', 02:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:44 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:44 INFO - 'SHELL': '/bin/bash', 02:23:44 INFO - 'SHLVL': '1', 02:23:44 INFO - 'TERM': 'linux', 02:23:44 INFO - 'TMOUT': '86400', 02:23:44 INFO - 'USER': 'cltbld', 02:23:44 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:44 INFO - '_': '/tools/buildbot/bin/python'} 02:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:44 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:23:46 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:23:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:23:46 INFO - Installing collected packages: mozsystemmonitor 02:23:46 INFO - Running setup.py install for mozsystemmonitor 02:23:46 INFO - Successfully installed mozsystemmonitor 02:23:46 INFO - Cleaning up... 02:23:46 INFO - Return code: 0 02:23:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 02:23: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')]} 02:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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', '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 0x7f97f2166f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, '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': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', '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 02:23: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 02:23: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 blobuploader==1.2.4 02:23:46 INFO - Using env: {'DISPLAY': ':0', 02:23:46 INFO - 'HOME': '/home/cltbld', 02:23:46 INFO - 'LANG': 'en_US.UTF-8', 02:23:46 INFO - 'LANGUAGE': 'en_US:en', 02:23:46 INFO - 'LOGNAME': 'cltbld', 02:23:46 INFO - 'MAIL': '/var/mail/cltbld', 02:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:46 INFO - 'MOZ_NO_REMOTE': '1', 02:23:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:46 INFO - 'NO_EM_RESTART': '1', 02:23:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:46 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:46 INFO - 'SHELL': '/bin/bash', 02:23:46 INFO - 'SHLVL': '1', 02:23:46 INFO - 'TERM': 'linux', 02:23:46 INFO - 'TMOUT': '86400', 02:23:46 INFO - 'USER': 'cltbld', 02:23:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:46 INFO - '_': '/tools/buildbot/bin/python'} 02:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:46 INFO - Downloading/unpacking blobuploader==1.2.4 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23:48 INFO - Downloading blobuploader-1.2.4.tar.gz 02:23:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:23:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23:48 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 02:23:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23: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 02:23:49 INFO - Downloading docopt-0.6.1.tar.gz 02:23:49 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 02:23:49 INFO - Installing collected packages: blobuploader, requests, docopt 02:23:49 INFO - Running setup.py install for blobuploader 02:23:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:23:49 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 02:23:49 INFO - Running setup.py install for requests 02:23:49 INFO - Running setup.py install for docopt 02:23:49 INFO - Successfully installed blobuploader requests docopt 02:23:49 INFO - Cleaning up... 02:23:49 INFO - Return code: 0 02:23:49 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:23: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')]} 02:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23: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')]} 02:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:49 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 0x7f97f2166f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, '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': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', '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 02:23:49 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 02:23:49 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 02:23:49 INFO - Using env: {'DISPLAY': ':0', 02:23:49 INFO - 'HOME': '/home/cltbld', 02:23:49 INFO - 'LANG': 'en_US.UTF-8', 02:23:49 INFO - 'LANGUAGE': 'en_US:en', 02:23:49 INFO - 'LOGNAME': 'cltbld', 02:23:49 INFO - 'MAIL': '/var/mail/cltbld', 02:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:49 INFO - 'MOZ_NO_REMOTE': '1', 02:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:49 INFO - 'NO_EM_RESTART': '1', 02:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:49 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:49 INFO - 'SHELL': '/bin/bash', 02:23:49 INFO - 'SHLVL': '1', 02:23:49 INFO - 'TERM': 'linux', 02:23:49 INFO - 'TMOUT': '86400', 02:23:49 INFO - 'USER': 'cltbld', 02:23:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:49 INFO - '_': '/tools/buildbot/bin/python'} 02:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:23:50 INFO - Running setup.py (path:/tmp/pip-IYzryu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:23:50 INFO - Running setup.py (path:/tmp/pip-8_uwAg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:23:50 INFO - Running setup.py (path:/tmp/pip-Mvc_4j-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:23:50 INFO - Running setup.py (path:/tmp/pip-Qp6jKH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:23:50 INFO - Running setup.py (path:/tmp/pip-J8fl3u-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:23:50 INFO - Running setup.py (path:/tmp/pip-VPRCyq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:23:50 INFO - Running setup.py (path:/tmp/pip-UlopwL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:23:50 INFO - Running setup.py (path:/tmp/pip-szbFPM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:23:50 INFO - Running setup.py (path:/tmp/pip-YxYVUp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:23:50 INFO - Running setup.py (path:/tmp/pip-39aONH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:23:50 INFO - Running setup.py (path:/tmp/pip-dDMXt7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:23:50 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:23:50 INFO - Running setup.py (path:/tmp/pip-Fl6SQU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:23:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:23:51 INFO - Running setup.py (path:/tmp/pip-1QljK1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:23:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:23:51 INFO - Running setup.py (path:/tmp/pip-_tlrCK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:23:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:23:51 INFO - Running setup.py (path:/tmp/pip-8QjBWS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:23:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:23:51 INFO - Running setup.py (path:/tmp/pip-lgRiXf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:23:51 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:23:51 INFO - Running setup.py (path:/tmp/pip-KndYsN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:23:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:23:51 INFO - Running setup.py install for manifestparser 02:23:51 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 02:23:51 INFO - Running setup.py install for mozcrash 02:23:51 INFO - Running setup.py install for mozdebug 02:23:51 INFO - Running setup.py install for mozdevice 02:23:51 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 02:23:51 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 02:23:51 INFO - Running setup.py install for mozfile 02:23:51 INFO - Running setup.py install for mozhttpd 02:23:51 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Running setup.py install for mozinfo 02:23:52 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Running setup.py install for mozInstall 02:23:52 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Running setup.py install for mozleak 02:23:52 INFO - Running setup.py install for mozlog 02:23:52 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Running setup.py install for moznetwork 02:23:52 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Running setup.py install for mozprocess 02:23:52 INFO - Running setup.py install for mozprofile 02:23:52 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Running setup.py install for mozrunner 02:23:52 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 02:23:52 INFO - Running setup.py install for mozscreenshot 02:23:52 INFO - Running setup.py install for moztest 02:23:53 INFO - Running setup.py install for mozversion 02:23:53 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 02:23:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:23:53 INFO - Cleaning up... 02:23:53 INFO - Return code: 0 02:23:53 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:53 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 0x7f97f2166f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, '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': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', '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 02:23:53 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 02:23:53 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 02:23:53 INFO - Using env: {'DISPLAY': ':0', 02:23:53 INFO - 'HOME': '/home/cltbld', 02:23:53 INFO - 'LANG': 'en_US.UTF-8', 02:23:53 INFO - 'LANGUAGE': 'en_US:en', 02:23:53 INFO - 'LOGNAME': 'cltbld', 02:23:53 INFO - 'MAIL': '/var/mail/cltbld', 02:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:53 INFO - 'MOZ_NO_REMOTE': '1', 02:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:53 INFO - 'NO_EM_RESTART': '1', 02:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:53 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:53 INFO - 'SHELL': '/bin/bash', 02:23:53 INFO - 'SHLVL': '1', 02:23:53 INFO - 'TERM': 'linux', 02:23:53 INFO - 'TMOUT': '86400', 02:23:53 INFO - 'USER': 'cltbld', 02:23:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:53 INFO - '_': '/tools/buildbot/bin/python'} 02:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:23:53 INFO - Running setup.py (path:/tmp/pip-CDdCva-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 02:23:53 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)) 02:23:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:23:53 INFO - Running setup.py (path:/tmp/pip-Zd9Qyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 02:23:53 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)) 02:23:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:23:53 INFO - Running setup.py (path:/tmp/pip-6b7mgw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 02:23:53 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)) 02:23:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:23:53 INFO - Running setup.py (path:/tmp/pip-slYUYa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 02:23:53 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)) 02:23:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 02:23:53 INFO - Running setup.py (path:/tmp/pip-bRps7T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 02:23:53 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)) 02:23:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:23:53 INFO - Running setup.py (path:/tmp/pip-F1NUCg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 02:23:53 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)) 02:23:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:23:53 INFO - Running setup.py (path:/tmp/pip-APQ7TT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 02:23:53 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)) 02:23:53 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:23:53 INFO - Running setup.py (path:/tmp/pip-rxsms5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 02:23:53 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)) 02:23:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 02:23:54 INFO - Running setup.py (path:/tmp/pip-5jqHgK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 02:23:54 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)) 02:23:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 02:23:54 INFO - Running setup.py (path:/tmp/pip-629A8T-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 02:23:54 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)) 02:23:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:23:54 INFO - Running setup.py (path:/tmp/pip-CUjhGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 02:23:54 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)) 02:23:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:23:54 INFO - Running setup.py (path:/tmp/pip-cMxRFn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 02:23:54 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)) 02:23:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:23:54 INFO - Running setup.py (path:/tmp/pip-2MZMIQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 02:23:54 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)) 02:23:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:23:54 INFO - Running setup.py (path:/tmp/pip-Ebbzzj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 02:23:54 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)) 02:23:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:23:54 INFO - Running setup.py (path:/tmp/pip-yRblYz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 02:23:54 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)) 02:23:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 02:23:54 INFO - Running setup.py (path:/tmp/pip-q7b_AM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 02:23:54 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)) 02:23:54 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 02:23:54 INFO - Running setup.py (path:/tmp/pip-F4b2Tw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 02:23:54 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)) 02:23:54 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)) 02:23:54 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)) 02:23:54 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)) 02:23:54 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)) 02:23:54 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)) 02:23:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 02:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:56 INFO - Downloading blessings-1.6.tar.gz 02:23:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 02:23:56 INFO - Installing collected packages: blessings 02:23:56 INFO - Running setup.py install for blessings 02:23:56 INFO - Successfully installed blessings 02:23:56 INFO - Cleaning up... 02:23:56 INFO - Return code: 0 02:23:56 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 02:23:56 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:23:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:23:56 INFO - Reading from file tmpfile_stdout 02:23:56 INFO - Current package versions: 02:23:56 INFO - argparse == 1.2.1 02:23:56 INFO - blessings == 1.6 02:23:56 INFO - blobuploader == 1.2.4 02:23:56 INFO - docopt == 0.6.1 02:23:56 INFO - manifestparser == 1.1 02:23:56 INFO - mozInstall == 1.12 02:23:56 INFO - mozcrash == 0.16 02:23:56 INFO - mozdebug == 0.1 02:23:56 INFO - mozdevice == 0.47 02:23:56 INFO - mozfile == 1.2 02:23:56 INFO - mozhttpd == 0.7 02:23:56 INFO - mozinfo == 0.9 02:23:56 INFO - mozleak == 0.1 02:23:56 INFO - mozlog == 3.1 02:23:56 INFO - moznetwork == 0.27 02:23:56 INFO - mozprocess == 0.22 02:23:56 INFO - mozprofile == 0.27 02:23:56 INFO - mozrunner == 6.11 02:23:56 INFO - mozscreenshot == 0.1 02:23:56 INFO - mozsystemmonitor == 0.0 02:23:56 INFO - moztest == 0.7 02:23:56 INFO - mozversion == 1.4 02:23:56 INFO - psutil == 3.1.1 02:23:56 INFO - requests == 1.2.3 02:23:56 INFO - wsgiref == 0.1.2 02:23:56 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 02:23:56 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')]} 02:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:56 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')]} 02:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:56 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 0x7f97f2166f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, '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': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', '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 02:23:56 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 02:23:56 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 02:23:56 INFO - Using env: {'DISPLAY': ':0', 02:23:56 INFO - 'HOME': '/home/cltbld', 02:23:56 INFO - 'LANG': 'en_US.UTF-8', 02:23:56 INFO - 'LANGUAGE': 'en_US:en', 02:23:56 INFO - 'LOGNAME': 'cltbld', 02:23:56 INFO - 'MAIL': '/var/mail/cltbld', 02:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:56 INFO - 'MOZ_NO_REMOTE': '1', 02:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:56 INFO - 'NO_EM_RESTART': '1', 02:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:56 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:56 INFO - 'SHELL': '/bin/bash', 02:23:56 INFO - 'SHLVL': '1', 02:23:56 INFO - 'TERM': 'linux', 02:23:56 INFO - 'TMOUT': '86400', 02:23:56 INFO - 'USER': 'cltbld', 02:23:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:56 INFO - '_': '/tools/buildbot/bin/python'} 02:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:57 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)) 02:23:57 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)) 02:23:57 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)) 02:23:57 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)) 02:23:57 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)) 02:23:57 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)) 02:23:57 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)) 02:23:57 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)) 02:23:57 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)) 02:23:57 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)) 02:23:57 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)) 02:23:57 INFO - Cleaning up... 02:23:57 INFO - Return code: 0 02:23:57 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 02:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:57 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 0x7f97f2166f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, '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': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', '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 02:23:57 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 02:23:57 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 02:23:57 INFO - Using env: {'DISPLAY': ':0', 02:23:57 INFO - 'HOME': '/home/cltbld', 02:23:57 INFO - 'LANG': 'en_US.UTF-8', 02:23:57 INFO - 'LANGUAGE': 'en_US:en', 02:23:57 INFO - 'LOGNAME': 'cltbld', 02:23:57 INFO - 'MAIL': '/var/mail/cltbld', 02:23:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:57 INFO - 'MOZ_NO_REMOTE': '1', 02:23:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:57 INFO - 'NO_EM_RESTART': '1', 02:23:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:57 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:57 INFO - 'SHELL': '/bin/bash', 02:23:57 INFO - 'SHLVL': '1', 02:23:57 INFO - 'TERM': 'linux', 02:23:57 INFO - 'TMOUT': '86400', 02:23:57 INFO - 'USER': 'cltbld', 02:23:57 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:23:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:57 INFO - '_': '/tools/buildbot/bin/python'} 02:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:57 INFO - Downloading/unpacking jsonschema 02:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:23:59 INFO - Downloading/unpacking functools32 (from jsonschema) 02:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:59 INFO - Downloading functools32-3.2.3-2.tar.gz 02:23:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 02:23:59 INFO - warning: no files found matching '*.txt' 02:23:59 INFO - no previously-included directories found matching 'build' 02:23:59 INFO - no previously-included directories found matching 'dist' 02:23:59 INFO - no previously-included directories found matching '.git*' 02:23:59 INFO - Installing collected packages: jsonschema, functools32 02:23:59 INFO - Running setup.py install for functools32 02:23:59 INFO - warning: no files found matching '*.txt' 02:23:59 INFO - no previously-included directories found matching 'build' 02:23:59 INFO - no previously-included directories found matching 'dist' 02:23:59 INFO - no previously-included directories found matching '.git*' 02:23:59 INFO - Successfully installed jsonschema functools32 02:23:59 INFO - Cleaning up... 02:23:59 INFO - Return code: 0 02:23:59 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 02:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:23:59 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 0x7f97f2166f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1adf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bad450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, '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': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', '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 02:23:59 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 02:23:59 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 02:23:59 INFO - Using env: {'DISPLAY': ':0', 02:23:59 INFO - 'HOME': '/home/cltbld', 02:23:59 INFO - 'LANG': 'en_US.UTF-8', 02:23:59 INFO - 'LANGUAGE': 'en_US:en', 02:23:59 INFO - 'LOGNAME': 'cltbld', 02:23:59 INFO - 'MAIL': '/var/mail/cltbld', 02:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:23:59 INFO - 'MOZ_NO_REMOTE': '1', 02:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:23:59 INFO - 'NO_EM_RESTART': '1', 02:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:23:59 INFO - 'PWD': '/builds/slave/test-pgo', 02:23:59 INFO - 'SHELL': '/bin/bash', 02:23:59 INFO - 'SHLVL': '1', 02:23:59 INFO - 'TERM': 'linux', 02:23:59 INFO - 'TMOUT': '86400', 02:23:59 INFO - 'USER': 'cltbld', 02:23:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:23:59 INFO - '_': '/tools/buildbot/bin/python'} 02:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:23:59 INFO - Downloading/unpacking flake8 02:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:24:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:24:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:24:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:24:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 02:24:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:02 INFO - no previously-included directories found matching 'docs/_build' 02:24:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:24:02 INFO - Running setup.py install for pep8 02:24:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:24:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:24:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:24:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:24:02 INFO - no previously-included directories found matching 'docs/_build' 02:24:02 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 02:24:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:24:02 INFO - Cleaning up... 02:24:02 INFO - Return code: 0 02:24:02 INFO - Running post-action listener: _resource_record_post_action 02:24:02 INFO - Running post-action listener: _start_resource_monitoring 02:24:02 INFO - Starting resource monitoring. 02:24:02 INFO - ##### 02:24:02 INFO - ##### Running install step. 02:24:02 INFO - ##### 02:24:02 INFO - Running pre-action listener: _resource_record_pre_action 02:24:02 INFO - Running main action method: install 02:24:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 02:24:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 02:24:02 INFO - Reading from file tmpfile_stdout 02:24:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:24:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 02:24:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 02:24:02 INFO - Reading from file tmpfile_stdout 02:24:02 INFO - Output received: 02:24:02 INFO - Usage: mozinstall [options] installer 02:24:02 INFO - Options: 02:24:02 INFO - -h, --help show this help message and exit 02:24:02 INFO - -d DEST, --destination=DEST 02:24:02 INFO - Directory to install application into. [default: 02:24:02 INFO - "/builds/slave/test-pgo"] 02:24:02 INFO - --app=APP Application being installed. [default: firefox] 02:24:02 INFO - mkdir: /builds/slave/test-pgo/build/application 02:24:02 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 02:24:02 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 02:24:17 INFO - Reading from file tmpfile_stdout 02:24:17 INFO - Output received: 02:24:17 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 02:24:17 INFO - Running post-action listener: _resource_record_post_action 02:24:17 INFO - ##### 02:24:17 INFO - ##### Running run-tests step. 02:24:17 INFO - ##### 02:24:17 INFO - Running pre-action listener: _resource_record_pre_action 02:24:17 INFO - Running main action method: run_tests 02:24:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 02:24:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 02:24:17 INFO - Python 2.7.3 02:24:17 INFO - Return code: 0 02:24:17 INFO - grabbing minidump binary from tooltool 02:24: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')]} 02:24:17 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 0x1c3fa50>, '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 0x1bab550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bab9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 02:24:17 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 02:24:17 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 02:24:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:24:17 INFO - Return code: 0 02:24:17 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 02:24:17 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 02:24:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 02:24:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 02:24:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 02:24:17 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 02:24:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 02:24:18 INFO - Return code: 0 02:24:18 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 02:24:18 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --webServer localhost 02:24:18 INFO - Using env: {'DISPLAY': ':0', 02:24:18 INFO - 'HOME': '/home/cltbld', 02:24:18 INFO - 'LANG': 'en_US.UTF-8', 02:24:18 INFO - 'LANGUAGE': 'en_US:en', 02:24:18 INFO - 'LOGNAME': 'cltbld', 02:24:18 INFO - 'MAIL': '/var/mail/cltbld', 02:24:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:24:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 02:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:24:18 INFO - 'MOZ_NO_REMOTE': '1', 02:24:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 02:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:24:18 INFO - 'NO_EM_RESTART': '1', 02:24:18 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 02:24:18 INFO - 'PWD': '/builds/slave/test-pgo', 02:24:18 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 02:24:18 INFO - 'SHELL': '/bin/bash', 02:24:18 INFO - 'SHLVL': '1', 02:24:18 INFO - 'TERM': 'linux', 02:24:18 INFO - 'TMOUT': '86400', 02:24:18 INFO - 'USER': 'cltbld', 02:24:18 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1453712460.489241-876706828', 02:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:24:18 INFO - '_': '/tools/buildbot/bin/python'} 02:24:18 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--webServer', 'localhost'] with output_timeout 3600 02:24:18 INFO - mozversion INFO | application_buildid: 20160125001712 02:24:18 INFO - mozversion INFO | application_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 02:24:18 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 02:24:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:24:18 INFO - mozversion INFO | application_name: Firefox 02:24:18 INFO - mozversion INFO | application_remotingname: firefox-dev 02:24:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:24:18 INFO - mozversion INFO | application_vendor: Mozilla 02:24:18 INFO - mozversion INFO | application_version: 45.0a2 02:24:18 INFO - mozversion INFO | platform_buildid: 20160125001712 02:24:18 INFO - mozversion INFO | platform_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 02:24:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:24:18 INFO - mozversion INFO | platform_version: 45.0a2 02:24:18 INFO - 2016-01-25 02:24:18,649 DEBUG : using testdate: 1453717458 02:24:18 INFO - 2016-01-25 02:24:18,649 DEBUG : actual date: 1453717458 02:24:18 INFO - 2016-01-25 02:24:18,663 INFO : starting webserver on 'localhost:32946' 02:24:18 INFO - 2016-01-25 02:24:18,664 INFO : Starting test suite talos-linux64-ix-016.e 02:24:18 INFO - 2016-01-25 02:24:18,664 INFO : Starting test dromaeo_css 02:24:18 INFO - 2016-01-25 02:24:18,664 DEBUG : operating with platform_type : linux_ 02:24:18 INFO - 2016-01-25 02:24:18,665 INFO : Initialising browser for dromaeo_css test... 02:24:18 INFO - 2016-01-25 02:24:18,681 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9gbQ05/profile http://localhost:32946/getInfo.html 02:24:22 INFO - 2016-01-25 02:24:22,164 DEBUG : BROWSER_OUTPUT: 02:24:22 INFO - 2016-01-25 02:24:22,164 DEBUG : BROWSER_OUTPUT: (process:12683): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:24:23 INFO - 2016-01-25 02:24:23,061 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:24:23 INFO - 2016-01-25 02:24:23,061 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:24:23 INFO - 2016-01-25 02:24:23,061 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:24:23 INFO - 2016-01-25 02:24:23,061 DEBUG : BROWSER_OUTPUT: __metrics 02:24:23 INFO - 2016-01-25 02:24:23,949 INFO : Browser initialized. 02:24:23 INFO - 2016-01-25 02:24:23,950 INFO : Running cycle 1/1 for dromaeo_css test... 02:24:23 INFO - 2016-01-25 02:24:23,950 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp9gbQ05/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:24:25 INFO - 2016-01-25 02:24:25,260 DEBUG : BROWSER_OUTPUT: 02:24:25 INFO - 2016-01-25 02:24:25,261 DEBUG : BROWSER_OUTPUT: (process:12799): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:24:35 INFO - 2016-01-25 02:24:35,762 DEBUG : BROWSER_OUTPUT: RSS: Main: 135499776 02:24:35 INFO - 2016-01-25 02:24:35,763 DEBUG : BROWSER_OUTPUT: 02:25:25 INFO - 2016-01-25 02:25:25,423 DEBUG : BROWSER_OUTPUT: 1453717525420 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] 02:27:33 INFO - 2016-01-25 02:27:33,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32946/tests/dromaeo/cssquery-ext.html) 02:27:34 INFO - 2016-01-25 02:27:34,772 DEBUG : BROWSER_OUTPUT: RSS: Main: 142192640 02:27:34 INFO - 2016-01-25 02:27:34,772 DEBUG : BROWSER_OUTPUT: 02:30:36 INFO - 2016-01-25 02:30:36,547 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/dromaeo/cssquery-ext.html (next: http://localhost:32946/tests/dromaeo/cssquery-jquery.html) 02:30:37 INFO - 2016-01-25 02:30:37,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 139579392 02:30:37 INFO - 2016-01-25 02:30:37,141 DEBUG : BROWSER_OUTPUT: 02:33:38 INFO - 2016-01-25 02:33:38,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32946/tests/dromaeo/cssquery-mootools.html) 02:33:39 INFO - 2016-01-25 02:33:39,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 138452992 02:33:39 INFO - 2016-01-25 02:33:39,314 DEBUG : BROWSER_OUTPUT: 02:36:40 INFO - 2016-01-25 02:36:40,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32946/tests/dromaeo/cssquery-prototype.html) 02:36:41 INFO - 2016-01-25 02:36:41,530 DEBUG : BROWSER_OUTPUT: RSS: Main: 139284480 02:36:41 INFO - 2016-01-25 02:36:41,530 DEBUG : BROWSER_OUTPUT: 02:39:43 INFO - 2016-01-25 02:39:43,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32946/tests/dromaeo/cssquery-yui.html) 02:39:44 INFO - 2016-01-25 02:39:44,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 140029952 02:39:44 INFO - 2016-01-25 02:39:44,442 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/dromaeo/cssquery-yui.html (next: http://localhost:32946/tests/dromaeo/cssquery-dojo.html) 02:42:46 INFO - 2016-01-25 02:42:46,930 DEBUG : BROWSER_OUTPUT: RSS: Main: 141250560 02:42:46 INFO - 2016-01-25 02:42:46,930 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,931 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:42:46 INFO - 2016-01-25 02:42:46,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:42:46 INFO - 2016-01-25 02:42:46,932 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:42:46 INFO - 2016-01-25 02:42:46,932 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:42:46 INFO - 2016-01-25 02:42:46,932 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3391.525186473894;3426.023583278763;3446.0178849028016;3472.583290005199;3483.7387195960296;5608.691521966291;5620.943790562093;5622.381538030813;5623.325200975889;5636.351819540754;5670.432956704338;5671.440353902679;5734.741936612852;5744.626599271044;5751.597388182829;5212.3484564429355;5226.764795584208;5266.025785229725;5283.365996080475;5299.443558426367;5060.11447996601;5137.357830271216;5165.276861239429;5171.482851714817;5242.449542797989;5183.922241166386;5269.420363759983;5269.710165940872;5275.815346462875;5276.472352764712;5176.327077479922;5226.895462090737;5267.420583735786;5289.1008528549855;5289.576833853283;4913.508649135058;4968.527989840959;5023.2214006829;5047.293378926916;5158.277841102249;5472.179173124024;5494.203340515643;5495.587830912697;5508.862278443031;5523.6685798852195;6148.938510614881;6150.7847225346895;6173.876522469571;6177.135201071854;6182.350853160398;5855.795047173371;5976.282846058501;6072.210612620375;6121.051237058263;6175.382461753834;5719.227904232958;5829.970850145722;5833.941660583382;5846.0061789495885;5847.678377689268;6279.466245369194;6312.274088479791;6314.336994615591;6318.241810982619;6326.936730632727;5701.914471282934;5786.942130578725;6021.638701677914;6123.984276525883;6125.357545073132;6191.504679625619;6222.377762223741;6225.968870155621;6251.906221406683;6268.435840774352;5854.5901786875365;6143.293521245025;6145.477634401037;6170.197874276315;6195.2255968004;6006.519478441714;6016.548758843104;6018.969905150446;6155.784547540815;6180.3201647818705;4584.106099310602;4599.356090147382;4602.217623004098;4612.815487380534;4658.95341046592;4055.270051390719;4153.854615088458;4160.209560183555;4169.520505141887;4170.35359519275;5655.208270842086;5746.2529871116485;5752.856178595485;5770.019096753562;5773.480386765212;6019.729112189962;6028.758849645965;6077.574569780161;6078;6083.695815209222;5503.3395992480355;5638;5778.739956701958;5781.277340332458;5803.129530570448;5231.790728370823;5246.868828279247;5256.2115682647145;5388.084025715638;5392.379876314274;6223.564350495421;6291.465225455796;6301.212348456443;6318.115463835067;6329;5930.229070220844;6109.999999999911;6179.62922224668;6197.752089916353;6204.5967012144065;5984.281886173687;6008.939910601013;6141.731496609992;6271.74913003493;6272.153259310117;5881.648418552235;6117.096718007557;6117.9187529241;6121.666376154749;6123.831729140362;5975.193348897843;6174.25908890936;6176.938230617816;6228.22147231596;6236.34518375564;5854.4730974212525;5896.882062358814;5979.820605381846;5990.4908082813445;6018.037114061729;5859.589828711949;5862.062070068769;5870.5010074144175;5935.643861368331;6034.788782392595;5670.886582268249;5774.249347584787;5808.477237048686;5825.359210486928;5857.824265272048;5712.828615141552;5799.8550036249435;5915.171875937286;6055.939440605537;6092.268927728701;5736.856578585402;5839.416058394297;5877.382874798084;5896.115582662635;5901.557383196363 02:42:46 INFO - 2016-01-25 02:42:46,935 DEBUG : BROWSER_OUTPUT: |1;ext.html;570.3099249907611;582.6882617799478;588.6203398807769;599.736116108912;613.4570904749298;42621.573784262146;43021.56978430215;43126.784366078165;43129.35305970413;43210.783946080264;46531.76734116333;46655.76672116643;46975;47148.76425617867;47208;8995.415298005624;9133.08669133088;9157.084291570856;9201.539923003857;9252.722418327427;8983.416077954913;9051.954740226289;9093.727188184364;9106.31702622306;9117.088291170896;9006.144416280444;9068.863967040466;9068.954655226715;9090.727278181632;9129;9082.364234503588;9098.454092754422;9122.908770912305;9166.404183728037;9168.129027742421;8986.056464071244;9116.179543841086;9134.497602631853;9143.542822858897;9150.039245879154;42873.57126428727;43160.136797263876;43176.352354714705;43216;43261;3607.8917632471066;3686.3364594373;3694;3697.371446854041;3765.6234376562397;31925.840370797996;32071.83964080188;32316.676833231602;32561.348773024405;33293.667063329296;3901.3757798752063;3923.920921746514;3938.8621398250925;4002.239574480839;4064.0652649890394;271545;271798;271985;459930;465958.67020665016;65803.67098164478;65948.34051659422;66421;66682;66842;71490.28509714836;71819.64090179515;71829.28170718226;71833;71909;16671.416500422427;16685.416010439818;16691.332346705996;16811.075390853377;16938;12659.936700316439;12843.678908027186;12886.711328867226;12899.290539020443;12911.35443227835;22415.663765043537;22682.319530414115;22700.772992269867;22702.886485567466;22748.20381286647;8361.790955226046;8527.23254907049;8720.520371379635;8792.38453308275;8793.296536277083;984.6799790068256;1023.7491814505345;1032.948352582368;1038.446412481275;1107.1087774341572;30000.849995749883;30051.69948300489;33707.83146084303;34545.13637159041;34770;1049.884512703602;1087.3910610058392;1146.9885301146883;1158.137187795098;1170.303669316755;15462.458813941457;15666.843331566766;15792.131432771308;17143.228554715068;18122.63754724898;521134;524940;527464;527955;803829;59749.70125149346;60491;60701;60779;61081;1458.7228426598913;1465.7801329800402;1470.6470447092834;1474.226031333537;1479.8150231221098;30815.53776693396;30831.69168308288;30891.536626950165;31808.204794880312;31838;53266.73366633142;54662.180067299814;54702;54829.1775623358;54874.17688734752;313778;315743;316044;316716;317368;44868.87827804331;44917.77541112404;45505;45645.402410915456;45746.542534574226;48580.2712959313;48702.02595948132;48756.756216218695;48766;49804;40294;42978.35532466953;43219.56780432281;43323.35014974715;43738;41874.37188442237;41918.58081419147;42319.36520952127;42563.57436425596;42714.359284611375;40602.187956240115;41142.58857411388;41389.58610413857;41597.58402415937;41627.7918610405;36287.455688165224;36628.81685591555;37066.444003339435;37333.43999840059;37662.623373767005;27948;28133.296667582654;28261.43477130487;28300.43399132047;28544.85727571349 02:42:46 INFO - 2016-01-25 02:42:46,936 DEBUG : BROWSER_OUTPUT: |2;jquery.html;379.6279645946972;381.17856020276315;386.1812956532152;388.7881104797884;391.15120189189463;16136.75794863078;17143.828561714377;17668.293268269284;19156.808431915695;19332.613347733055;17198.74201886973;18480.47647930316;18489.167987440564;18517.35189268376;18548.165332560035;5177.792888284464;5346.572274218053;5370.91943620846;5371.194320851864;5376.569874410038;5211.5049070338255;5294.52349288564;5300.681959082448;5348.786048558072;5362.4637536246455;5301.655392399482;5322.840314790563;5333.653312534692;5556.944430555704;6130.785422510213;6019.548533859978;6035.155078289043;6085.9391406085815;6092.847678808021;6113.847153821168;5269.525742683177;5362.812301569426;5365.597580181502;5367.677939323653;5481.068218402881;13126;13328.533501327407;13378.93310533441;18588.442346729484;21565.67651485229;2238.9552208955893;2239.944001399962;2276.84062115652;2287.2680742162515;2347.5657003454417;9319.114684105067;9358.812823743556;10124.94937525315;10403.947980260125;11430.485628146753;1837.3661086925124;1847.5935294235246;1852.4998250472297;1977.32770857909;2054.1783286685295;63332.68333658348;67177.32822671809;67381.32618673799;68083;69303;9931.950340248397;10518.316309439862;11111.388873611868;11184.105271578253;11206.439678016066;12909.967202623768;12954.222746635232;12986.805197922038;13066.23605813203;13073.673158171121;7489.962550187214;7665.808354791175;7894.407919406068;7897.565633890191;8081.434299598972;7693.230676932262;7714.151443341228;7728.304452599293;7749.535027898231;7757.379409647215;4291;4553.021100463417;4596.149712303235;4602.2636378180005;4874.610031197496;1828.2595548802756;1960.0101948515908;1964.2143142743016;1967.9704804427945;1973.8618296719378;1023.2070145637191;1069.8716154061563;1072.1637123044038;1072.1797824664138;1105.9612913547987;16439;16772;16917.49247522576;17175.742363864552;17468.563285917953;991.5835349153373;993.60752502761;1000.5097502224004;1019.8011387779312;1106.4965440724452;10247.7438064049;10273.280870339004;10274.589016439259;10303.227257955534;10344.689659310232;627511;635681;650748;655345;658248;76756.61621691856;86288;88849.55575222212;89786.55106724556;90146;1207.1489599832098;1225.9211893533634;1229.2317301686626;1233.3278363292027;1233.6730766346925;16401.09793961296;16483.373787619912;16631.501054968372;16786.916065419595;16956.74564881503;37434.2262616598;38293.23413531658;38376.23247534978;38592.80703596464;39475;49835.75082124566;51137;51277.48722512727;51678.741606291725;53950.73024634852;10144.188464922936;10165.644202452879;10225.590976360862;10254.6410875619;10467.581296748349;12455.626331210078;17302.567435814206;17633.382831600833;18054.819451805313;18402;14956;15010.324535395715;15063.096214227182;15274.541763747106;15395.153266570445;13852.099613525088;14224.14655120696;14590.19753913545;14656.926715366355;14850.331735072165;15359;15575.299111539782;15662.216889155725;15763.842361576237;15787.131707756183;10030.34802737849;10132.13876820449;10178.694639160836;10187.694369168938;10260.948695256775;10880.401577912975;11010.39442830652;14107.647308817363;14852.108873467627;15069.924650377117 02:42:46 INFO - 2016-01-25 02:42:46,940 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1477.4238047161616;1764.8676349273803;1810.908400797079;1841.199078400895;1871.055117165831;7335.963320183405;7571.73498927537;7607.467477276586;7640.770776876689;7815.49199302045;7770.0287464067;7837.255460731221;7845.450818442711;7851.254130857574;7863.252990965863;2273.465735552148;2317.640765681322;2317.80298674612;2320.176337400224;2321.3268152235833;2299.6895419118455;2315.9305220843316;2344.4842134730334;2348.612478940973;2355.34050465869;2007.8694884832512;2037.2156719662962;2204.669299605056;2255.661650752384;2283.977160228393;2241.8094461970672;2242.0471299697647;2246.786555277246;2249.988750056247;2251.4821591034156;2242.618754811686;2303.366574192094;2312.9190478333344;2318.8840557972035;2320.1299512682745;7614.2766437188375;7721.22787721229;7747.651355689008;7769.7669069928;7775.8444831103625;4567.6574256930535;4646.837360692393;4690.226112691402;4695.460022097468;4697.812087516495;2952.0848536953613;2976.613040304768;2983.701629837021;3000.294930691286;3018.2303512604367;924.3529529329496;930.1675000874247;939.272064150289;941.7268991992314;958.8226178157063;10326.7418314542;10429.79140417195;10438.634647787367;10448.425336606484;10480.213983951235;4090.9181816363507;4094.3653733671326;4196.265653510623;4196.748195108304;4199.139176468817;8560.315174786127;8577.313814894793;8637.956810215908;8669.436486628476;8689.13108689126;4536.3422303765765;4546.636269098464;4549.181147393501;4558.521355257716;4563.543645635476;4173.853915112956;4197;4201.579842015774;4214.283571792803;4222.809973551198;3364.8654053838063;3423.2639982403903;3425.8972230832615;3427.7771944823508;3428.3828910795796;1013.7110923386799;1014.1785154025116;1026.1277913773383;1028.311031608824;1042.3016578892161;1115.5872327238974;1118.7986162490668;1171.0455978377595;1329.8271224740915;1358.5245164192652;7149.9285007149265;7204.963975180195;7205.89191162133;7226.168990566047;7234.457415693844;1055.5830446973403;1236.2211806561809;1270.1934271737514;1273.1660762200772;1287.1183239480986;5599.412061733459;5612.691301978431;5631.4087020863035;5643.209950606918;5651.4348565143155;8884.555772211364;9318.906810931803;9378.48418336998;9428.858567121499;9438.716838494856;9125.498097604695;9161.954190229006;9201.171894529525;9299.256059515223;9379.062093790702;6988.545744526589;7193.208747037822;7246.311600398059;7264.745733899394;7306.926930730625;7008.649567521502;7021.297870212938;7050.083489146378;7101.2898710128575;7102.076730025064;8010.118886922317;8150.7147249845975;8247.340212782843;8331.875021874797;8333.874991875005;8286.46138001028;8330.083690794128;8340.165983401612;8403.41176117666;8433.114522975;6757.898631520629;6965.860682786215;7018.859622807618;7020.333068358498;7026.543274687129;7473.103227612722;7492.587907665131;7493.737719179802;7547.622618868925;7554.622268886424;6819.147606549182;6991.126109236346;7169.605671688108;7241.348278654947;7245;6472.5145614080075;6812.420944219797;6925.6190909500465;6954.165500140016;7066.470014748812;7031.191412987572;7110.182329032021;7143.535670181422;7151.928480715126;7160.8925866113095;6162;6263.123162757309;6272.090546870587;6308.053791931247;6322.778702745566;6347.5239357047485;6388.169537960035;6398.1362516059735;6410.743570257324;6433 02:42:46 INFO - 2016-01-25 02:42:46,940 DEBUG : BROWSER_OUTPUT: |4;prototype.html;330.48939388644544;336.9957526570819;363.52378384316546;365.24212259561415;367.23431645020133;6386.712597933092;6399.776007839727;6430.839229019265;6462.741490340387;6576.0793488911595;6366.108744775735;6390.265119511258;6390.584612000217;6403.519736019805;6417.711202995864;4859.902801943959;4860.538248866361;4869.780859861297;4873;4874.098291816008;4881.072596206727;4881.877953051185;4883.438404583483;4886.560209581137;4889.437714662806;4671.929921051187;4705.12955103307;4809.326694262789;4818.638602104838;4851.369321988137;4781.043791241731;4803.759812009385;4807.879803004917;4808;4814.7833347499445;4131.462909821704;4160.625543701081;4161.0221597924765;4166.312558427856;4171.6036976487485;6046.516278697738;6061.575689701723;6064.757409703607;6069.969650151766;6086.2958371656005;5527.419620939783;5549.694766787825;5593.440655934414;5598.44015598441;5610.66336019836;6700.463962882957;6727;6743.831404214934;6751.864962700718;6754.088198093244;4595.356650068993;4612.561806628365;4613.446386433616;4617.468991066037;4629.560191781776;6879.862402751917;6951.617661028641;7009.228984811667;7010;7050.5769653820935;4701.318308845198;4730.88172795676;4740.715557066587;4744.312074749142;4744.908671005688;4775.5463230993;4795.968866693608;4808.807647694123;4814.085323788469;4820.891195025164;5583.804566840141;5586.190002449622;5590.944090559124;5610.85972850682;5634.887302253932;6644.837153498119;6825.1809782825385;6860.245373008965;6868.656567171622;6869.381755642016;1664;1701.8978861268363;1703.1058694185404;1703.2250326101594;1707.1208327711238;1119.3339962722168;1127.3461392392392;1137.7895089408487;1143.0284258380477;1144.0733006264952;6587.473002159912;6639.933600664028;6651.634160121143;6660.267370589231;6662.200535935719;7063.788086357417;7080;7084.185318688416;7084.752033678797;7085.858282834418;6493.837654058591;6503.512236582275;6564.179477565304;6627.966860165765;6676.666166691646;3784.4701741756176;3821.9617803821607;3827.942580861289;3830.138218900725;3855.614438556178;7251.492395532262;7285.089363829521;7293.744718934918;7320.707171713072;7336.303051210127;7132.500724949204;7283.526570772989;7301.306375894282;7305.707771689073;7306.561606303639;7309.634518274065;7315.524490908074;7329.413646908234;7336.449766267551;7338.5596864187255;7110.253423390676;7111.857762844611;7116.217216106328;7119.1457025157315;7123.786286411416;6766.357196066366;6944.548604340702;6949.409300209337;7011.053507776385;7040.894386584103;7299.160596531467;7324.19433862264;7333.376662983706;7337.853242935218;7338.046054013158;4630.953690463052;4640.234361330343;4644.628429725546;4650.465196502446;4670.906581868411;6992.965035174791;7141.392981596622;7155.856882862209;7166.104236970379;7182.892256616259;6979.1973922999505;6979.755708550177;6983.44132469391;6983.476239281973;6987;6781.355771201728;6911.170659520689;6955.860882782417;6972.233054364117;6981.720731170696;6762.222344430256;6766.695498702472;6805.9659701701175;6824.52228344031;6828.351306625863;6949.548279361826;6961.269066747918;6968.895466568107;6983.301669832976;7006;6636.303188165173;6712.463002959849;6792.762253321308;6793.796186114425;6819 02:42:46 INFO - 2016-01-25 02:42:46,941 DEBUG : BROWSER_OUTPUT: |5;yui.html;842.5660784695881;843.2452954605628;872.2498651159997;873.6505397840859;884.1335491218606;13501.2574308413;13563.32183390829;13595.728085438297;13622.04645674802;13633.590992270223;13844;14155.716885662281;14188.574342769733;14202.36089375978;14206;876.8290183414236;915.5193523400202;916.7249825052457;918.1828172926067;918.4213945214539;868.9739307820776;897.9673375618027;908.6592527802075;910.126278772376;910.9863352049724;954.4750387286999;961.7451375385529;970.9757256068619;971.3249291742206;971.9028097190295;953.6185525789671;956.4213650741306;963.2967933408615;964.2382517810921;966.6809952715657;695.655650453029;702.0311969482133;706.9893951590731;707.886738121898;707.91505019398;14129.929350353284;14170.291485425687;14209;14209.928950355183;14273.072250303698;12590.81113783294;12872.356382180853;13138.540151094665;13403.329833508285;13563.59309220725;11257;11259.774804503946;11376.488058037408;11475.254108482923;11637.47631356591;3785.3943369061094;3833.616638336172;3865;3872.7289089763726;4035.1324465240114;53014.46985530134;53507;53517.73241133808;53922;53922.730386347816;10541.84187237192;10648.254622176373;10724.731881702864;11021.889781102087;11181;19273.072692730613;19466.805331946784;19687.212511499667;19725.408237752603;19736.506587335145;8073.475224110414;8097.554634495159;8148.511089334659;8194;8263.132371101068;4749.453812811502;4799.6400269979895;4813.78337974792;4820.734859582686;4912.238603016467;3168.3980043791607;3168.651448340681;3172.9682703173135;3186.139742269574;3217.2439476722952;580.8925348810399;594.0346936228628;595.3570144244293;602.3945934335965;603.3785201242727;684.3464491410691;692.5429216716942;712.2450202784961;713.2332742302046;730.536109570416;8337.624806883705;8443.746687599381;8637.265832404317;8703.303735701129;8771.692990745294;551.4320250142359;693.0643631097977;704.2148004974416;729.580491217552;741.8182545276442;3901.43429202764;4247.214265360918;4324.718893271927;4348.978255108705;4385;65205.34794651993;65835.34164658388;65958;66216.33783662198;66663.33336666669;57779.4222057774;57781.711091444275;58815.70592147097;59247;59399;53514.464855351725;53840.19239711407;53891.46108538864;54108;54484.72757636187;8723.825523489622;8889.955550222208;9280.164785169367;9340.53297335144;9375.578098985698;36625.81687091548;40401.79799100986;40806.38790418087;41457;42023;44957.775211123735;48545;48854;50344;50371.74814125906;11461.312321260752;11560.075193984292;11989.820152697543;12117.27296362221;12193.146479746332;12750.362481875683;13413.061085724295;13515.797263041259;13695.315234238447;14319.856801431852;11785.469653865768;11799;12027.579034733742;12355.876441235472;12425.93787031059;11541.076713863038;11812.70468238301;11871.169018168644;12158;12302.81545776832;10916.64963536404;11405.201635885409;11567.01680357179;12410.875891241334;12412.193207441487;10695.03744662984;10791;10889.618863339745;11281.830772538255;11352.148588855704;9517.476538790155;10389.84415233757;10463.529141188512;10578.312409693346;10579.206559508222 02:42:46 INFO - 2016-01-25 02:42:46,941 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:42:46 INFO - 2016-01-25 02:42:46,941 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:42:46 INFO - 2016-01-25 02:42:46,941 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,295 02:42:46 INFO - 2016-01-25 02:42:46,942 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:42:46 INFO - 2016-01-25 02:42:46,942 DEBUG : BROWSER_OUTPUT: __startTimestamp1453718566929__endTimestamp 02:42:46 INFO - 2016-01-25 02:42:46,942 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,942 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:42:46 INFO - 2016-01-25 02:42:46,942 DEBUG : BROWSER_OUTPUT: Number of tests: 6 02:42:46 INFO - 2016-01-25 02:42:46,942 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,942 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5656.51 Median:5839.42 stddev:632.92 (10.8%) stddev-sans-first:609.41 02:42:46 INFO - 2016-01-25 02:42:46,943 DEBUG : BROWSER_OUTPUT: Values: 3391.5 3426.0 3446.0 3472.6 3483.7 5608.7 5620.9 5622.4 5623.3 5636.4 5670.4 5671.4 5734.7 5744.6 5751.6 5212.3 5226.8 5266.0 5283.4 5299.4 5060.1 5137.4 5165.3 5171.5 5242.4 5183.9 5269.4 5269.7 5275.8 5276.5 5176.3 5226.9 5267.4 5289.1 5289.6 4913.5 4968.5 5023.2 5047.3 5158.3 5472.2 5494.2 5495.6 5508.9 5523.7 6148.9 6150.8 6173.9 6177.1 6182.4 5855.8 5976.3 6072.2 6121.1 6175.4 5719.2 5830.0 5833.9 5846.0 5847.7 6279.5 6312.3 6314.3 6318.2 6326.9 5701.9 5786.9 6021.6 6124.0 6125.4 6191.5 6222.4 6226.0 6251.9 6268.4 5854.6 6143.3 6145.5 6170.2 6195.2 6006.5 6016.5 6019.0 6155.8 6180.3 4584.1 4599.4 4602.2 4612.8 4659.0 4055.3 4153.9 4160.2 4169.5 4170.4 5655.2 5746.3 5752.9 5770.0 5773.5 6019.7 6028.8 6077.6 6078.0 6083.7 5503.3 5638.0 5778.7 5781.3 5803.1 5231.8 5246.9 5256.2 5388.1 5392.4 6223.6 6291.5 6301.2 6318.1 6329.0 5930.2 6110.0 6179.6 6197.8 6204.6 5984.3 6008.9 6141.7 6271.7 6272.2 5881.6 6117.1 6117.9 6121.7 6123.8 5975.2 6174.3 6176.9 6228.2 6236.3 5854.5 5896.9 5979.8 5990.5 6018.0 5859.6 5862.1 5870.5 5935.6 6034.8 5670.9 5774.2 5808.5 5825.4 5857.8 5712.8 5799.9 5915.2 6055.9 6092.3 5736.9 5839.4 5877.4 5896.1 5901.6 02:42:46 INFO - 2016-01-25 02:42:46,943 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,943 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:59672.51 Median:42999.96 stddev:117063.86 (272.2%) stddev-sans-first:117308.15 02:42:46 INFO - 2016-01-25 02:42:46,944 DEBUG : BROWSER_OUTPUT: Values: 570.3 582.7 588.6 599.7 613.5 42621.6 43021.6 43126.8 43129.4 43210.8 46531.8 46655.8 46975.0 47148.8 47208.0 8995.4 9133.1 9157.1 9201.5 9252.7 8983.4 9052.0 9093.7 9106.3 9117.1 9006.1 9068.9 9069.0 9090.7 9129.0 9082.4 9098.5 9122.9 9166.4 9168.1 8986.1 9116.2 9134.5 9143.5 9150.0 42873.6 43160.1 43176.4 43216.0 43261.0 3607.9 3686.3 3694.0 3697.4 3765.6 31925.8 32071.8 32316.7 32561.3 33293.7 3901.4 3923.9 3938.9 4002.2 4064.1 271545.0 271798.0 271985.0 459930.0 465958.7 65803.7 65948.3 66421.0 66682.0 66842.0 71490.3 71819.6 71829.3 71833.0 71909.0 16671.4 16685.4 16691.3 16811.1 16938.0 12659.9 12843.7 12886.7 12899.3 12911.4 22415.7 22682.3 22700.8 22702.9 22748.2 8361.8 8527.2 8720.5 8792.4 8793.3 984.7 1023.7 1032.9 1038.4 1107.1 30000.8 30051.7 33707.8 34545.1 34770.0 1049.9 1087.4 1147.0 1158.1 1170.3 15462.5 15666.8 15792.1 17143.2 18122.6 521134.0 524940.0 527464.0 527955.0 803829.0 59749.7 60491.0 60701.0 60779.0 61081.0 1458.7 1465.8 1470.6 1474.2 1479.8 30815.5 30831.7 30891.5 31808.2 31838.0 53266.7 54662.2 54702.0 54829.2 54874.2 313778.0 315743.0 316044.0 316716.0 317368.0 44868.9 44917.8 45505.0 45645.4 45746.5 48580.3 48702.0 48756.8 48766.0 49804.0 40294.0 42978.4 43219.6 43323.4 43738.0 41874.4 41918.6 42319.4 42563.6 42714.4 40602.2 41142.6 41389.6 41597.6 41627.8 36287.5 36628.8 37066.4 37333.4 37662.6 27948.0 28133.3 28261.4 28300.4 28544.9 02:42:46 INFO - 2016-01-25 02:42:46,944 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,944 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:32555.53 Median:18872.63 stddev:105496.40 (559.0%) stddev-sans-first:105764.68 02:42:46 INFO - 2016-01-25 02:42:46,944 DEBUG : BROWSER_OUTPUT: Values: 379.6 381.2 386.2 388.8 391.2 16136.8 17143.8 17668.3 19156.8 19332.6 17198.7 18480.5 18489.2 18517.4 18548.2 5177.8 5346.6 5370.9 5371.2 5376.6 5211.5 5294.5 5300.7 5348.8 5362.5 5301.7 5322.8 5333.7 5556.9 6130.8 6019.5 6035.2 6085.9 6092.8 6113.8 5269.5 5362.8 5365.6 5367.7 5481.1 13126.0 13328.5 13378.9 18588.4 21565.7 2239.0 2239.9 2276.8 2287.3 2347.6 9319.1 9358.8 10124.9 10403.9 11430.5 1837.4 1847.6 1852.5 1977.3 2054.2 63332.7 67177.3 67381.3 68083.0 69303.0 9932.0 10518.3 11111.4 11184.1 11206.4 12910.0 12954.2 12986.8 13066.2 13073.7 7490.0 7665.8 7894.4 7897.6 8081.4 7693.2 7714.2 7728.3 7749.5 7757.4 4291.0 4553.0 4596.1 4602.3 4874.6 1828.3 1960.0 1964.2 1968.0 1973.9 1023.2 1069.9 1072.2 1072.2 1106.0 16439.0 16772.0 16917.5 17175.7 17468.6 991.6 993.6 1000.5 1019.8 1106.5 10247.7 10273.3 10274.6 10303.2 10344.7 627511.0 635681.0 650748.0 655345.0 658248.0 76756.6 86288.0 88849.6 89786.6 90146.0 1207.1 1225.9 1229.2 1233.3 1233.7 16401.1 16483.4 16631.5 16786.9 16956.7 37434.2 38293.2 38376.2 38592.8 39475.0 49835.8 51137.0 51277.5 51678.7 53950.7 10144.2 10165.6 10225.6 10254.6 10467.6 12455.6 17302.6 17633.4 18054.8 18402.0 14956.0 15010.3 15063.1 15274.5 15395.2 13852.1 14224.1 14590.2 14656.9 14850.3 15359.0 15575.3 15662.2 15763.8 15787.1 10030.3 10132.1 10178.7 10187.7 10260.9 10880.4 11010.4 14107.6 14852.1 15069.9 02:42:46 INFO - 2016-01-25 02:42:46,944 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,944 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5390.44 Median:6367.85 stddev:2770.13 (43.5%) stddev-sans-first:2762.29 02:42:46 INFO - 2016-01-25 02:42:46,945 DEBUG : BROWSER_OUTPUT: Values: 1477.4 1764.9 1810.9 1841.2 1871.1 7336.0 7571.7 7607.5 7640.8 7815.5 7770.0 7837.3 7845.5 7851.3 7863.3 2273.5 2317.6 2317.8 2320.2 2321.3 2299.7 2315.9 2344.5 2348.6 2355.3 2007.9 2037.2 2204.7 2255.7 2284.0 2241.8 2242.0 2246.8 2250.0 2251.5 2242.6 2303.4 2312.9 2318.9 2320.1 7614.3 7721.2 7747.7 7769.8 7775.8 4567.7 4646.8 4690.2 4695.5 4697.8 2952.1 2976.6 2983.7 3000.3 3018.2 924.4 930.2 939.3 941.7 958.8 10326.7 10429.8 10438.6 10448.4 10480.2 4090.9 4094.4 4196.3 4196.7 4199.1 8560.3 8577.3 8638.0 8669.4 8689.1 4536.3 4546.6 4549.2 4558.5 4563.5 4173.9 4197.0 4201.6 4214.3 4222.8 3364.9 3423.3 3425.9 3427.8 3428.4 1013.7 1014.2 1026.1 1028.3 1042.3 1115.6 1118.8 1171.0 1329.8 1358.5 7149.9 7205.0 7205.9 7226.2 7234.5 1055.6 1236.2 1270.2 1273.2 1287.1 5599.4 5612.7 5631.4 5643.2 5651.4 8884.6 9318.9 9378.5 9428.9 9438.7 9125.5 9162.0 9201.2 9299.3 9379.1 6988.5 7193.2 7246.3 7264.7 7306.9 7008.6 7021.3 7050.1 7101.3 7102.1 8010.1 8150.7 8247.3 8331.9 8333.9 8286.5 8330.1 8340.2 8403.4 8433.1 6757.9 6965.9 7018.9 7020.3 7026.5 7473.1 7492.6 7493.7 7547.6 7554.6 6819.1 6991.1 7169.6 7241.3 7245.0 6472.5 6812.4 6925.6 6954.2 7066.5 7031.2 7110.2 7143.5 7151.9 7160.9 6162.0 6263.1 6272.1 6308.1 6322.8 6347.5 6388.2 6398.1 6410.7 6433.0 02:42:46 INFO - 2016-01-25 02:42:46,945 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,946 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5695.17 Median:6533.85 stddev:1753.98 (26.8%) stddev-sans-first:1712.06 02:42:46 INFO - 2016-01-25 02:42:46,947 DEBUG : BROWSER_OUTPUT: Values: 330.5 337.0 363.5 365.2 367.2 6386.7 6399.8 6430.8 6462.7 6576.1 6366.1 6390.3 6390.6 6403.5 6417.7 4859.9 4860.5 4869.8 4873.0 4874.1 4881.1 4881.9 4883.4 4886.6 4889.4 4671.9 4705.1 4809.3 4818.6 4851.4 4781.0 4803.8 4807.9 4808.0 4814.8 4131.5 4160.6 4161.0 4166.3 4171.6 6046.5 6061.6 6064.8 6070.0 6086.3 5527.4 5549.7 5593.4 5598.4 5610.7 6700.5 6727.0 6743.8 6751.9 6754.1 4595.4 4612.6 4613.4 4617.5 4629.6 6879.9 6951.6 7009.2 7010.0 7050.6 4701.3 4730.9 4740.7 4744.3 4744.9 4775.5 4796.0 4808.8 4814.1 4820.9 5583.8 5586.2 5590.9 5610.9 5634.9 6644.8 6825.2 6860.2 6868.7 6869.4 1664.0 1701.9 1703.1 1703.2 1707.1 1119.3 1127.3 1137.8 1143.0 1144.1 6587.5 6639.9 6651.6 6660.3 6662.2 7063.8 7080.0 7084.2 7084.8 7085.9 6493.8 6503.5 6564.2 6628.0 6676.7 3784.5 3822.0 3827.9 3830.1 3855.6 7251.5 7285.1 7293.7 7320.7 7336.3 7132.5 7283.5 7301.3 7305.7 7306.6 7309.6 7315.5 7329.4 7336.4 7338.6 7110.3 7111.9 7116.2 7119.1 7123.8 6766.4 6944.5 6949.4 7011.1 7040.9 7299.2 7324.2 7333.4 7337.9 7338.0 4631.0 4640.2 4644.6 4650.5 4670.9 6993.0 7141.4 7155.9 7166.1 7182.9 6979.2 6979.8 6983.4 6983.5 6987.0 6781.4 6911.2 6955.9 6972.2 6981.7 6762.2 6766.7 6806.0 6824.5 6828.4 6949.5 6961.3 6968.9 6983.3 7006.0 6636.3 6712.5 6792.8 6793.8 6819.0 02:42:46 INFO - 2016-01-25 02:42:46,947 DEBUG : BROWSER_OUTPUT: 02:42:46 INFO - 2016-01-25 02:42:46,947 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:15265.41 Median:4774.55 stddev:18183.33 (380.8%) stddev-sans-first:18202.08 02:42:46 INFO - 2016-01-25 02:42:46,947 DEBUG : BROWSER_OUTPUT: Values: 842.6 843.2 872.2 873.7 884.1 13501.3 13563.3 13595.7 13622.0 13633.6 13844.0 14155.7 14188.6 14202.4 14206.0 876.8 915.5 916.7 918.2 918.4 869.0 898.0 908.7 910.1 911.0 954.5 961.7 971.0 971.3 971.9 953.6 956.4 963.3 964.2 966.7 695.7 702.0 707.0 707.9 707.9 14129.9 14170.3 14209.0 14209.9 14273.1 12590.8 12872.4 13138.5 13403.3 13563.6 11257.0 11259.8 11376.5 11475.3 11637.5 3785.4 3833.6 3865.0 3872.7 4035.1 53014.5 53507.0 53517.7 53922.0 53922.7 10541.8 10648.3 10724.7 11021.9 11181.0 19273.1 19466.8 19687.2 19725.4 19736.5 8073.5 8097.6 8148.5 8194.0 8263.1 4749.5 4799.6 4813.8 4820.7 4912.2 3168.4 3168.7 3173.0 3186.1 3217.2 580.9 594.0 595.4 602.4 603.4 684.3 692.5 712.2 713.2 730.5 8337.6 8443.7 8637.3 8703.3 8771.7 551.4 693.1 704.2 729.6 741.8 3901.4 4247.2 4324.7 4349.0 4385.0 65205.3 65835.3 65958.0 66216.3 66663.3 57779.4 57781.7 58815.7 59247.0 59399.0 53514.5 53840.2 53891.5 54108.0 54484.7 8723.8 8890.0 9280.2 9340.5 9375.6 36625.8 40401.8 40806.4 41457.0 42023.0 44957.8 48545.0 48854.0 50344.0 50371.7 11461.3 11560.1 11989.8 12117.3 12193.1 12750.4 13413.1 13515.8 13695.3 14319.9 11785.5 11799.0 12027.6 12355.9 12425.9 11541.1 11812.7 11871.2 12158.0 12302.8 10916.6 11405.2 11567.0 12410.9 12412.2 10695.0 10791.0 10889.6 11281.8 11352.1 9517.5 10389.8 10463.5 10578.3 10579.2 02:42:46 INFO - 2016-01-25 02:42:46,947 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:42:46 INFO - 2016-01-25 02:42:46,947 DEBUG : BROWSER_OUTPUT: 02:42:47 INFO - 2016-01-25 02:42:47,589 INFO : Browser exited with error code: 0 02:42:47 INFO - 2016-01-25 02:42:47,608 INFO : Completed test dromaeo_css (00:18:28) 02:42:47 INFO - 2016-01-25 02:42:47,608 INFO : Starting test kraken 02:42:47 INFO - 2016-01-25 02:42:47,608 DEBUG : operating with platform_type : linux_ 02:42:47 INFO - 2016-01-25 02:42:47,609 INFO : Initialising browser for kraken test... 02:42:47 INFO - 2016-01-25 02:42:47,615 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxdI4RJ/profile http://localhost:32946/getInfo.html 02:42:51 INFO - 2016-01-25 02:42:51,096 DEBUG : BROWSER_OUTPUT: 02:42:51 INFO - 2016-01-25 02:42:51,096 DEBUG : BROWSER_OUTPUT: (process:13060): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:42:51 INFO - 2016-01-25 02:42:51,919 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:42:51 INFO - 2016-01-25 02:42:51,919 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:42:51 INFO - 2016-01-25 02:42:51,919 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:42:51 INFO - 2016-01-25 02:42:51,919 DEBUG : BROWSER_OUTPUT: __metrics 02:42:52 INFO - 2016-01-25 02:42:52,865 INFO : Browser initialized. 02:42:52 INFO - 2016-01-25 02:42:52,866 INFO : Running cycle 1/1 for kraken test... 02:42:52 INFO - 2016-01-25 02:42:52,866 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpxdI4RJ/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:42:54 INFO - 2016-01-25 02:42:54,098 DEBUG : BROWSER_OUTPUT: 02:42:54 INFO - 2016-01-25 02:42:54,099 DEBUG : BROWSER_OUTPUT: (process:13174): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:43:04 INFO - 2016-01-25 02:43:04,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 138133504 02:43:04 INFO - 2016-01-25 02:43:04,608 DEBUG : BROWSER_OUTPUT: 02:43:07 INFO - 2016-01-25 02:43:07,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32946/tests/kraken/driver.html?testName=audio-beat-detection) 02:43:07 INFO - 2016-01-25 02:43:07,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 137437184 02:43:07 INFO - 2016-01-25 02:43:07,661 DEBUG : BROWSER_OUTPUT: 02:43:10 INFO - 2016-01-25 02:43:10,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32946/tests/kraken/driver.html?testName=audio-dft) 02:43:10 INFO - 2016-01-25 02:43:10,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 138665984 02:43:10 INFO - 2016-01-25 02:43:10,847 DEBUG : BROWSER_OUTPUT: 02:43:13 INFO - 2016-01-25 02:43:13,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32946/tests/kraken/driver.html?testName=audio-fft) 02:43:14 INFO - 2016-01-25 02:43:14,256 DEBUG : BROWSER_OUTPUT: RSS: Main: 139182080 02:43:14 INFO - 2016-01-25 02:43:14,256 DEBUG : BROWSER_OUTPUT: 02:43:16 INFO - 2016-01-25 02:43:16,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32946/tests/kraken/driver.html?testName=audio-oscillator) 02:43:16 INFO - 2016-01-25 02:43:16,880 DEBUG : BROWSER_OUTPUT: RSS: Main: 138354688 02:43:16 INFO - 2016-01-25 02:43:16,880 DEBUG : BROWSER_OUTPUT: 02:43:19 INFO - 2016-01-25 02:43:19,074 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32946/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:43:19 INFO - 2016-01-25 02:43:19,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 138600448 02:43:19 INFO - 2016-01-25 02:43:19,648 DEBUG : BROWSER_OUTPUT: 02:43:22 INFO - 2016-01-25 02:43:22,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32946/tests/kraken/driver.html?testName=imaging-darkroom) 02:43:23 INFO - 2016-01-25 02:43:23,148 DEBUG : BROWSER_OUTPUT: RSS: Main: 139206656 02:43:23 INFO - 2016-01-25 02:43:23,148 DEBUG : BROWSER_OUTPUT: 02:43:26 INFO - 2016-01-25 02:43:26,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32946/tests/kraken/driver.html?testName=imaging-desaturate) 02:43:27 INFO - 2016-01-25 02:43:27,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 139649024 02:43:27 INFO - 2016-01-25 02:43:27,112 DEBUG : BROWSER_OUTPUT: 02:43:29 INFO - 2016-01-25 02:43:29,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32946/tests/kraken/driver.html?testName=json-parse-financial) 02:43:30 INFO - 2016-01-25 02:43:30,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 139116544 02:43:30 INFO - 2016-01-25 02:43:30,483 DEBUG : BROWSER_OUTPUT: 02:43:32 INFO - 2016-01-25 02:43:32,044 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32946/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:43:32 INFO - 2016-01-25 02:43:32,613 DEBUG : BROWSER_OUTPUT: RSS: Main: 139304960 02:43:32 INFO - 2016-01-25 02:43:32,613 DEBUG : BROWSER_OUTPUT: 02:43:34 INFO - 2016-01-25 02:43:34,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32946/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:43:35 INFO - 2016-01-25 02:43:35,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 138215424 02:43:35 INFO - 2016-01-25 02:43:35,028 DEBUG : BROWSER_OUTPUT: 02:43:37 INFO - 2016-01-25 02:43:37,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32946/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:43:37 INFO - 2016-01-25 02:43:37,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 139190272 02:43:37 INFO - 2016-01-25 02:43:37,674 DEBUG : BROWSER_OUTPUT: 02:43:40 INFO - 2016-01-25 02:43:40,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:43:40 INFO - 2016-01-25 02:43:40,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 139870208 02:43:40 INFO - 2016-01-25 02:43:40,671 DEBUG : BROWSER_OUTPUT: 02:43:43 INFO - 2016-01-25 02:43:43,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:43:43 INFO - 2016-01-25 02:43:43,774 DEBUG : BROWSER_OUTPUT: RSS: Main: 138870784 02:43:43 INFO - 2016-01-25 02:43:43,775 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,416 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32946/tests/kraken/driver.html?testName=ai-astar) 02:43:45 INFO - 2016-01-25 02:43:45,666 DEBUG : BROWSER_OUTPUT: RSS: Main: 140124160 02:43:45 INFO - 2016-01-25 02:43:45,666 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,667 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:43:45 INFO - 2016-01-25 02:43:45,668 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:43:45 INFO - 2016-01-25 02:43:45,668 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:43:45 INFO - 2016-01-25 02:43:45,668 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:43:45 INFO - 2016-01-25 02:43:45,668 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;106;111;112;112;121;112;111;110;111 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;151;123;144;157;123;157;154;121;159;123 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;162;162;162;161;160;163;162 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;74;164;73;73;73;73;173;71 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;132;93;93;94;137;93;94;140 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;109;109;110;110;110 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;145;146;146;146;147;146;147 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;95;96;96;98;97;96;96 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;59;62;60;59;63;59;59;58;57 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;65;65;66;65;66;65;64;64;66;66 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;82;81;82;84;82;81;82;83;83 02:43:45 INFO - 2016-01-25 02:43:45,669 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;113;123;126;126;113;118;115;112;122;122 02:43:45 INFO - 2016-01-25 02:43:45,670 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;147;150;142;158;144;148;142;135;135 02:43:45 INFO - 2016-01-25 02:43:45,670 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;65;65;66;65;66;64;65;64;71;66 02:43:45 INFO - 2016-01-25 02:43:45,670 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:43:45 INFO - 2016-01-25 02:43:45,670 DEBUG : BROWSER_OUTPUT: __start_cc_report 02:43:45 INFO - 2016-01-25 02:43:45,671 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,691 02:43:45 INFO - 2016-01-25 02:43:45,671 DEBUG : BROWSER_OUTPUT: __end_cc_report 02:43:45 INFO - 2016-01-25 02:43:45,671 DEBUG : BROWSER_OUTPUT: __startTimestamp1453718625666__endTimestamp 02:43:45 INFO - 2016-01-25 02:43:45,671 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,671 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:43:45 INFO - 2016-01-25 02:43:45,671 DEBUG : BROWSER_OUTPUT: Number of tests: 14 02:43:45 INFO - 2016-01-25 02:43:45,672 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,672 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.80 Median:112.00 stddev:3.71 (3.3%) stddev-sans-first:3.93 02:43:45 INFO - 2016-01-25 02:43:45,673 DEBUG : BROWSER_OUTPUT: Values: 112.0 106.0 111.0 112.0 112.0 121.0 112.0 111.0 110.0 111.0 02:43:45 INFO - 2016-01-25 02:43:45,673 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,673 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:141.20 Median:152.50 stddev:16.62 (10.9%) stddev-sans-first:17.24 02:43:45 INFO - 2016-01-25 02:43:45,673 DEBUG : BROWSER_OUTPUT: Values: 151.0 123.0 144.0 157.0 123.0 157.0 154.0 121.0 159.0 123.0 02:43:45 INFO - 2016-01-25 02:43:45,673 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,674 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 02:43:45 INFO - 2016-01-25 02:43:45,674 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 162.0 162.0 162.0 161.0 160.0 163.0 162.0 02:43:45 INFO - 2016-01-25 02:43:45,674 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,674 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:92.00 Median:73.00 stddev:40.38 (55.3%) stddev-sans-first:42.31 02:43:45 INFO - 2016-01-25 02:43:45,674 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 74.0 164.0 73.0 73.0 73.0 73.0 173.0 71.0 02:43:45 INFO - 2016-01-25 02:43:45,674 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,674 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.20 Median:93.00 stddev:20.88 (22.5%) stddev-sans-first:21.60 02:43:45 INFO - 2016-01-25 02:43:45,675 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 132.0 93.0 93.0 94.0 137.0 93.0 94.0 140.0 02:43:45 INFO - 2016-01-25 02:43:45,675 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,675 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 02:43:45 INFO - 2016-01-25 02:43:45,675 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 109.0 109.0 110.0 110.0 110.0 02:43:45 INFO - 2016-01-25 02:43:45,675 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,675 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:43:45 INFO - 2016-01-25 02:43:45,675 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 145.0 146.0 146.0 146.0 147.0 146.0 147.0 02:43:45 INFO - 2016-01-25 02:43:45,675 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,676 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 02:43:45 INFO - 2016-01-25 02:43:45,676 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 95.0 96.0 96.0 98.0 97.0 96.0 96.0 02:43:45 INFO - 2016-01-25 02:43:45,676 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,676 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.50 Median:59.00 stddev:1.78 (3.0%) stddev-sans-first:1.88 02:43:45 INFO - 2016-01-25 02:43:45,676 DEBUG : BROWSER_OUTPUT: Values: 59.0 59.0 62.0 60.0 59.0 63.0 59.0 59.0 58.0 57.0 02:43:45 INFO - 2016-01-25 02:43:45,676 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,676 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:65.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 02:43:45 INFO - 2016-01-25 02:43:45,677 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 66.0 65.0 66.0 65.0 64.0 64.0 66.0 66.0 02:43:45 INFO - 2016-01-25 02:43:45,677 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,677 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:82.50 stddev:1.51 (1.8%) stddev-sans-first:0.97 02:43:45 INFO - 2016-01-25 02:43:45,677 DEBUG : BROWSER_OUTPUT: Values: 86.0 82.0 81.0 82.0 84.0 82.0 81.0 82.0 83.0 83.0 02:43:45 INFO - 2016-01-25 02:43:45,677 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,677 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:119.00 Median:122.00 stddev:5.48 (4.5%) stddev-sans-first:5.36 02:43:45 INFO - 2016-01-25 02:43:45,677 DEBUG : BROWSER_OUTPUT: Values: 113.0 123.0 126.0 126.0 113.0 118.0 115.0 112.0 122.0 122.0 02:43:45 INFO - 2016-01-25 02:43:45,678 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,678 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:147.00 stddev:6.91 (4.7%) stddev-sans-first:7.28 02:43:45 INFO - 2016-01-25 02:43:45,678 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 150.0 142.0 158.0 144.0 148.0 142.0 135.0 135.0 02:43:45 INFO - 2016-01-25 02:43:45,678 DEBUG : BROWSER_OUTPUT: 02:43:45 INFO - 2016-01-25 02:43:45,678 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:65.50 stddev:2.00 (3.1%) stddev-sans-first:2.11 02:43:45 INFO - 2016-01-25 02:43:45,678 DEBUG : BROWSER_OUTPUT: Values: 65.0 65.0 66.0 65.0 66.0 64.0 65.0 64.0 71.0 66.0 02:43:45 INFO - 2016-01-25 02:43:45,678 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:43:45 INFO - 2016-01-25 02:43:45,679 DEBUG : BROWSER_OUTPUT: 02:43:46 INFO - 2016-01-25 02:43:46,493 INFO : Browser exited with error code: 0 02:43:46 INFO - 2016-01-25 02:43:46,549 INFO : Completed test kraken (00:00:58) 02:43:46 INFO - 2016-01-25 02:43:46,549 INFO : Starting test v8_7 02:43:46 INFO - 2016-01-25 02:43:46,549 DEBUG : operating with platform_type : linux_ 02:43:46 INFO - 2016-01-25 02:43:46,549 INFO : Initialising browser for v8_7 test... 02:43:46 INFO - 2016-01-25 02:43:46,556 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvcyAOA/profile http://localhost:32946/getInfo.html 02:43:50 INFO - 2016-01-25 02:43:50,042 DEBUG : BROWSER_OUTPUT: 02:43:50 INFO - 2016-01-25 02:43:50,042 DEBUG : BROWSER_OUTPUT: (process:13484): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:43:50 INFO - 2016-01-25 02:43:50,866 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 02:43:50 INFO - 2016-01-25 02:43:50,866 DEBUG : BROWSER_OUTPUT: colorDepth:24 02:43:50 INFO - 2016-01-25 02:43:50,866 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 02:43:50 INFO - 2016-01-25 02:43:50,866 DEBUG : BROWSER_OUTPUT: __metrics 02:43:51 INFO - 2016-01-25 02:43:51,793 INFO : Browser initialized. 02:43:51 INFO - 2016-01-25 02:43:51,794 INFO : Running cycle 1/1 for v8_7 test... 02:43:51 INFO - 2016-01-25 02:43:51,794 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpvcyAOA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 02:43:53 INFO - 2016-01-25 02:43:53,117 DEBUG : BROWSER_OUTPUT: 02:43:53 INFO - 2016-01-25 02:43:53,118 DEBUG : BROWSER_OUTPUT: (process:13597): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 02:44:03 INFO - 2016-01-25 02:44:03,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 136085504 02:44:03 INFO - 2016-01-25 02:44:03,626 DEBUG : BROWSER_OUTPUT: 02:44:24 INFO - 2016-01-25 02:44:24,992 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:32946/tests/v8_7/run.html (next: http://localhost:32946/tests/v8_7/run.html) 02:44:25 INFO - 2016-01-25 02:44:25,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 136024064 02:44:25 INFO - 2016-01-25 02:44:25,243 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,243 DEBUG : BROWSER_OUTPUT: __start_tp_report 02:44:25 INFO - 2016-01-25 02:44:25,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 02:44:25 INFO - 2016-01-25 02:44:25,243 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 02:44:25 INFO - 2016-01-25 02:44:25,243 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 02:44:25 INFO - 2016-01-25 02:44:25,244 DEBUG : BROWSER_OUTPUT: |0;Richards;164.5548790521639 02:44:25 INFO - 2016-01-25 02:44:25,244 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;167.02856188408217 02:44:25 INFO - 2016-01-25 02:44:25,244 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.00945232137894 02:44:25 INFO - 2016-01-25 02:44:25,244 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 02:44:25 INFO - 2016-01-25 02:44:25,244 DEBUG : BROWSER_OUTPUT: |4;RayTrace;931.0986964618249 02:44:25 INFO - 2016-01-25 02:44:25,244 DEBUG : BROWSER_OUTPUT: |5;Earley;544.9591280653951 02:44:25 INFO - 2016-01-25 02:44:25,244 DEBUG : BROWSER_OUTPUT: |6;Boyer;11098.901098901099 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: |7;RegExp;24142.85714285714 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: |8;Splay;515.1983513652756 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: __end_tp_report 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: __startTimestamp1453718665240__endTimestamp 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: Number of tests: 10 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.55 Median:164.55 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: Values: 164.6 02:44:25 INFO - 2016-01-25 02:44:25,245 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:167.03 Median:167.03 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: Values: 167.0 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.01 Median:278.01 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: Values: 278.0 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: Values: 5186.5 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:931.10 Median:931.10 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: Values: 931.1 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:544.96 Median:544.96 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,246 DEBUG : BROWSER_OUTPUT: Values: 545.0 02:44:25 INFO - 2016-01-25 02:44:25,247 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,247 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11098.90 Median:11098.90 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,247 DEBUG : BROWSER_OUTPUT: Values: 11098.9 02:44:25 INFO - 2016-01-25 02:44:25,247 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,247 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:24142.86 Median:24142.86 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,247 DEBUG : BROWSER_OUTPUT: Values: 24142.9 02:44:25 INFO - 2016-01-25 02:44:25,247 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,248 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:515.20 Median:515.20 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,248 DEBUG : BROWSER_OUTPUT: Values: 515.2 02:44:25 INFO - 2016-01-25 02:44:25,248 DEBUG : BROWSER_OUTPUT: 02:44:25 INFO - 2016-01-25 02:44:25,248 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 02:44:25 INFO - 2016-01-25 02:44:25,248 DEBUG : BROWSER_OUTPUT: Values: 4845.4 02:44:25 INFO - 2016-01-25 02:44:25,248 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 02:44:25 INFO - 2016-01-25 02:44:25,248 DEBUG : BROWSER_OUTPUT: 02:44:26 INFO - 2016-01-25 02:44:26,038 INFO : Browser exited with error code: 0 02:44:26 INFO - 2016-01-25 02:44:26,054 INFO : Completed test v8_7 (00:00:39) 02:44:26 INFO - 2016-01-25 02:44:26,304 INFO : Completed test suite (00:20:07) 02:44:26 INFO - 2016-01-25 02:44:26,304 DEBUG : Working with test: dromaeo_css 02:44:26 INFO - 2016-01-25 02:44:26,304 DEBUG : Generating results file: dromaeo_css 02:44:26 INFO - 2016-01-25 02:44:26,305 DEBUG : Working with test: kraken 02:44:26 INFO - 2016-01-25 02:44:26,306 DEBUG : Generating results file: kraken 02:44:26 INFO - 2016-01-25 02:44:26,306 INFO : javascript benchmark 02:44:26 INFO - 2016-01-25 02:44:26,306 DEBUG : Working with test: v8_7 02:44:26 INFO - 2016-01-25 02:44:26,306 DEBUG : Generating results file: v8_7 02:44:26 INFO - 2016-01-25 02:44:26,306 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:44:26 INFO - 2016-01-25 02:44:26,360 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 02:44:26 INFO - 2016-01-25 02:44:26,361 DEBUG : process_Request line: dromaeo_css 7445.53 graph.html#tests=[[72,52,43]] 02:44:26 INFO - 2016-01-25 02:44:26,361 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:44:26 INFO - 2016-01-25 02:44:26,395 DEBUG : process_Request line: kraken 1501.60 graph.html#tests=[[232,52,43]] 02:44:26 INFO - 2016-01-25 02:44:26,395 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 02:44:26 INFO - 2016-01-25 02:44:26,420 DEBUG : process_Request line: v8_7 23256.46 graph.html#tests=[[230,52,43]] 02:44:26 INFO - 2016-01-25 02:44:26,422 INFO : javascript benchmark 02:44:26 INFO - 2016-01-25 02:44:26,425 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3391.525186473894, 3426.023583278763, 3446.0178849028016, 3472.583290005199, 3483.7387195960296, 5608.691521966291, 5620.943790562093, 5622.381538030813, 5623.325200975889, 5636.351819540754, 5670.432956704338, 5671.440353902679, 5734.741936612852, 5744.626599271044, 5751.597388182829, 5212.3484564429355, 5226.764795584208, 5266.025785229725, 5283.365996080475, 5299.443558426367, 5060.11447996601, 5137.357830271216, 5165.276861239429, 5171.482851714817, 5242.449542797989, 5183.922241166386, 5269.420363759983, 5269.710165940872, 5275.815346462875, 5276.472352764712, 5176.327077479922, 5226.895462090737, 5267.420583735786, 5289.1008528549855, 5289.576833853283, 4913.508649135058, 4968.527989840959, 5023.2214006829, 5047.293378926916, 5158.277841102249, 5472.179173124024, 5494.203340515643, 5495.587830912697, 5508.862278443031, 5523.6685798852195, 6148.938510614881, 6150.7847225346895, 6173.876522469571, 6177.135201071854, 6182.350853160398, 5855.795047173371, 5976.282846058501, 6072.210612620375, 6121.051237058263, 6175.382461753834, 5719.227904232958, 5829.970850145722, 5833.941660583382, 5846.0061789495885, 5847.678377689268, 6279.466245369194, 6312.274088479791, 6314.336994615591, 6318.241810982619, 6326.936730632727, 5701.914471282934, 5786.942130578725, 6021.638701677914, 6123.984276525883, 6125.357545073132, 6191.504679625619, 6222.377762223741, 6225.968870155621, 6251.906221406683, 6268.435840774352, 5854.5901786875365, 6143.293521245025, 6145.477634401037, 6170.197874276315, 6195.2255968004, 6006.519478441714, 6016.548758843104, 6018.969905150446, 6155.784547540815, 6180.3201647818705, 4584.106099310602, 4599.356090147382, 4602.217623004098, 4612.815487380534, 4658.95341046592, 4055.270051390719, 4153.854615088458, 4160.209560183555, 4169.520505141887, 4170.35359519275, 5655.208270842086, 5746.2529871116485, 5752.856178595485, 5770.019096753562, 5773.480386765212, 6019.729112189962, 6028.758849645965, 6077.574569780161, 6078.0, 6083.695815209222, 5503.3395992480355, 5638.0, 5778.739956701958, 5781.277340332458, 5803.129530570448, 5231.790728370823, 5246.868828279247, 5256.2115682647145, 5388.084025715638, 5392.379876314274, 6223.564350495421, 6291.465225455796, 6301.212348456443, 6318.115463835067, 6329.0, 5930.229070220844, 6109.999999999911, 6179.62922224668, 6197.752089916353, 6204.5967012144065, 5984.281886173687, 6008.939910601013, 6141.731496609992, 6271.74913003493, 6272.153259310117, 5881.648418552235, 6117.096718007557, 6117.9187529241, 6121.666376154749, 6123.831729140362, 5975.193348897843, 6174.25908890936, 6176.938230617816, 6228.22147231596, 6236.34518375564, 5854.4730974212525, 5896.882062358814, 5979.820605381846, 5990.4908082813445, 6018.037114061729, 5859.589828711949, 5862.062070068769, 5870.5010074144175, 5935.643861368331, 6034.788782392595, 5670.886582268249, 5774.249347584787, 5808.477237048686, 5825.359210486928, 5857.824265272048, 5712.828615141552, 5799.8550036249435, 5915.171875937286, 6055.939440605537, 6092.268927728701, 5736.856578585402, 5839.416058394297, 5877.382874798084, 5896.115582662635, 5901.557383196363], "unit": "ms", "name": "dojo.html", "value": 5615.574333733814}, {"lowerIsBetter": false, "replicates": [570.3099249907611, 582.6882617799478, 588.6203398807769, 599.736116108912, 613.4570904749298, 42621.573784262146, 43021.56978430215, 43126.784366078165, 43129.35305970413, 43210.783946080264, 46531.76734116333, 46655.76672116643, 46975.0, 47148.76425617867, 47208.0, 8995.415298005624, 9133.08669133088, 9157.084291570856, 9201.539923003857, 9252.722418327427, 8983.416077954913, 9051.954740226289, 9093.727188184364, 9106.31702622306, 9117.088291170896, 9006.144416280444, 9068.863967040466, 9068.954655226715, 9090.727278181632, 9129.0, 9082.364234503588, 9098.454092754422, 9122.908770912305, 9166.404183728037, 9168.129027742421, 8986.056464071244, 9116.179543841086, 9134.497602631853, 9143.542822858897, 9150.039245879154, 42873.57126428727, 43160.136797263876, 43176.352354714705, 43216.0, 43261.0, 3607.8917632471066, 3686.3364594373, 3694.0, 3697.371446854041, 3765.6234376562397, 31925.840370797996, 32071.83964080188, 32316.676833231602, 32561.348773024405, 33293.667063329296, 3901.3757798752063, 3923.920921746514, 3938.8621398250925, 4002.239574480839, 4064.0652649890394, 271545.0, 271798.0, 271985.0, 459930.0, 465958.67020665016, 65803.67098164478, 65948.34051659422, 66421.0, 66682.0, 66842.0, 71490.28509714836, 71819.64090179515, 71829.28170718226, 71833.0, 71909.0, 16671.416500422427, 16685.416010439818, 16691.332346705996, 16811.075390853377, 16938.0, 12659.936700316439, 12843.678908027186, 12886.711328867226, 12899.290539020443, 12911.35443227835, 22415.663765043537, 22682.319530414115, 22700.772992269867, 22702.886485567466, 22748.20381286647, 8361.790955226046, 8527.23254907049, 8720.520371379635, 8792.38453308275, 8793.296536277083, 984.6799790068256, 1023.7491814505345, 1032.948352582368, 1038.446412481275, 1107.1087774341572, 30000.849995749883, 30051.69948300489, 33707.83146084303, 34545.13637159041, 34770.0, 1049.884512703602, 1087.3910610058392, 1146.9885301146883, 1158.137187795098, 1170.303669316755, 15462.458813941457, 15666.843331566766, 15792.131432771308, 17143.228554715068, 18122.63754724898, 521134.0, 524940.0, 527464.0, 527955.0, 803829.0, 59749.70125149346, 60491.0, 60701.0, 60779.0, 61081.0, 1458.7228426598913, 1465.7801329800402, 1470.6470447092834, 1474.226031333537, 1479.8150231221098, 30815.53776693396, 30831.69168308288, 30891.536626950165, 31808.204794880312, 31838.0, 53266.73366633142, 54662.180067299814, 54702.0, 54829.1775623358, 54874.17688734752, 313778.0, 315743.0, 316044.0, 316716.0, 317368.0, 44868.87827804331, 44917.77541112404, 45505.0, 45645.402410915456, 45746.542534574226, 48580.2712959313, 48702.02595948132, 48756.756216218695, 48766.0, 49804.0, 40294.0, 42978.35532466953, 43219.56780432281, 43323.35014974715, 43738.0, 41874.37188442237, 41918.58081419147, 42319.36520952127, 42563.57436425596, 42714.359284611375, 40602.187956240115, 41142.58857411388, 41389.58610413857, 41597.58402415937, 41627.7918610405, 36287.455688165224, 36628.81685591555, 37066.444003339435, 37333.43999840059, 37662.623373767005, 27948.0, 28133.296667582654, 28261.43477130487, 28300.43399132047, 28544.85727571349], "unit": "ms", "name": "ext.html", "value": 20875.205974842498}, {"lowerIsBetter": false, "replicates": [379.6279645946972, 381.17856020276315, 386.1812956532152, 388.7881104797884, 391.15120189189463, 16136.75794863078, 17143.828561714377, 17668.293268269284, 19156.808431915695, 19332.613347733055, 17198.74201886973, 18480.47647930316, 18489.167987440564, 18517.35189268376, 18548.165332560035, 5177.792888284464, 5346.572274218053, 5370.91943620846, 5371.194320851864, 5376.569874410038, 5211.5049070338255, 5294.52349288564, 5300.681959082448, 5348.786048558072, 5362.4637536246455, 5301.655392399482, 5322.840314790563, 5333.653312534692, 5556.944430555704, 6130.785422510213, 6019.548533859978, 6035.155078289043, 6085.9391406085815, 6092.847678808021, 6113.847153821168, 5269.525742683177, 5362.812301569426, 5365.597580181502, 5367.677939323653, 5481.068218402881, 13126.0, 13328.533501327407, 13378.93310533441, 18588.442346729484, 21565.67651485229, 2238.9552208955893, 2239.944001399962, 2276.84062115652, 2287.2680742162515, 2347.5657003454417, 9319.114684105067, 9358.812823743556, 10124.94937525315, 10403.947980260125, 11430.485628146753, 1837.3661086925124, 1847.5935294235246, 1852.4998250472297, 1977.32770857909, 2054.1783286685295, 63332.68333658348, 67177.32822671809, 67381.32618673799, 68083.0, 69303.0, 9931.950340248397, 10518.316309439862, 11111.388873611868, 11184.105271578253, 11206.439678016066, 12909.967202623768, 12954.222746635232, 12986.805197922038, 13066.23605813203, 13073.673158171121, 7489.962550187214, 7665.808354791175, 7894.407919406068, 7897.565633890191, 8081.434299598972, 7693.230676932262, 7714.151443341228, 7728.304452599293, 7749.535027898231, 7757.379409647215, 4291.0, 4553.021100463417, 4596.149712303235, 4602.2636378180005, 4874.610031197496, 1828.2595548802756, 1960.0101948515908, 1964.2143142743016, 1967.9704804427945, 1973.8618296719378, 1023.2070145637191, 1069.8716154061563, 1072.1637123044038, 1072.1797824664138, 1105.9612913547987, 16439.0, 16772.0, 16917.49247522576, 17175.742363864552, 17468.563285917953, 991.5835349153373, 993.60752502761, 1000.5097502224004, 1019.8011387779312, 1106.4965440724452, 10247.7438064049, 10273.280870339004, 10274.589016439259, 10303.227257955534, 10344.689659310232, 627511.0, 635681.0, 650748.0, 655345.0, 658248.0, 76756.61621691856, 86288.0, 88849.55575222212, 89786.55106724556, 90146.0, 1207.1489599832098, 1225.9211893533634, 1229.2317301686626, 1233.3278363292027, 1233.6730766346925, 16401.09793961296, 16483.373787619912, 16631.501054968372, 16786.916065419595, 16956.74564881503, 37434.2262616598, 38293.23413531658, 38376.23247534978, 38592.80703596464, 39475.0, 49835.75082124566, 51137.0, 51277.48722512727, 51678.741606291725, 53950.73024634852, 10144.188464922936, 10165.644202452879, 10225.590976360862, 10254.6410875619, 10467.581296748349, 12455.626331210078, 17302.567435814206, 17633.382831600833, 18054.819451805313, 18402.0, 14956.0, 15010.324535395715, 15063.096214227182, 15274.541763747106, 15395.153266570445, 13852.099613525088, 14224.14655120696, 14590.19753913545, 14656.926715366355, 14850.331735072165, 15359.0, 15575.299111539782, 15662.216889155725, 15763.842361576237, 15787.131707756183, 10030.34802737849, 10132.13876820449, 10178.694639160836, 10187.694369168938, 10260.948695256775, 10880.401577912975, 11010.39442830652, 14107.647308817363, 14852.108873467627, 15069.924650377117], "unit": "ms", "name": "jquery.html", "value": 9314.459517820173}, {"lowerIsBetter": false, "replicates": [1477.4238047161616, 1764.8676349273803, 1810.908400797079, 1841.199078400895, 1871.055117165831, 7335.963320183405, 7571.73498927537, 7607.467477276586, 7640.770776876689, 7815.49199302045, 7770.0287464067, 7837.255460731221, 7845.450818442711, 7851.254130857574, 7863.252990965863, 2273.465735552148, 2317.640765681322, 2317.80298674612, 2320.176337400224, 2321.3268152235833, 2299.6895419118455, 2315.9305220843316, 2344.4842134730334, 2348.612478940973, 2355.34050465869, 2007.8694884832512, 2037.2156719662962, 2204.669299605056, 2255.661650752384, 2283.977160228393, 2241.8094461970672, 2242.0471299697647, 2246.786555277246, 2249.988750056247, 2251.4821591034156, 2242.618754811686, 2303.366574192094, 2312.9190478333344, 2318.8840557972035, 2320.1299512682745, 7614.2766437188375, 7721.22787721229, 7747.651355689008, 7769.7669069928, 7775.8444831103625, 4567.6574256930535, 4646.837360692393, 4690.226112691402, 4695.460022097468, 4697.812087516495, 2952.0848536953613, 2976.613040304768, 2983.701629837021, 3000.294930691286, 3018.2303512604367, 924.3529529329496, 930.1675000874247, 939.272064150289, 941.7268991992314, 958.8226178157063, 10326.7418314542, 10429.79140417195, 10438.634647787367, 10448.425336606484, 10480.213983951235, 4090.9181816363507, 4094.3653733671326, 4196.265653510623, 4196.748195108304, 4199.139176468817, 8560.315174786127, 8577.313814894793, 8637.956810215908, 8669.436486628476, 8689.13108689126, 4536.3422303765765, 4546.636269098464, 4549.181147393501, 4558.521355257716, 4563.543645635476, 4173.853915112956, 4197.0, 4201.579842015774, 4214.283571792803, 4222.809973551198, 3364.8654053838063, 3423.2639982403903, 3425.8972230832615, 3427.7771944823508, 3428.3828910795796, 1013.7110923386799, 1014.1785154025116, 1026.1277913773383, 1028.311031608824, 1042.3016578892161, 1115.5872327238974, 1118.7986162490668, 1171.0455978377595, 1329.8271224740915, 1358.5245164192652, 7149.9285007149265, 7204.963975180195, 7205.89191162133, 7226.168990566047, 7234.457415693844, 1055.5830446973403, 1236.2211806561809, 1270.1934271737514, 1273.1660762200772, 1287.1183239480986, 5599.412061733459, 5612.691301978431, 5631.4087020863035, 5643.209950606918, 5651.4348565143155, 8884.555772211364, 9318.906810931803, 9378.48418336998, 9428.858567121499, 9438.716838494856, 9125.498097604695, 9161.954190229006, 9201.171894529525, 9299.256059515223, 9379.062093790702, 6988.545744526589, 7193.208747037822, 7246.311600398059, 7264.745733899394, 7306.926930730625, 7008.649567521502, 7021.297870212938, 7050.083489146378, 7101.2898710128575, 7102.076730025064, 8010.118886922317, 8150.7147249845975, 8247.340212782843, 8331.875021874797, 8333.874991875005, 8286.46138001028, 8330.083690794128, 8340.165983401612, 8403.41176117666, 8433.114522975, 6757.898631520629, 6965.860682786215, 7018.859622807618, 7020.333068358498, 7026.543274687129, 7473.103227612722, 7492.587907665131, 7493.737719179802, 7547.622618868925, 7554.622268886424, 6819.147606549182, 6991.126109236346, 7169.605671688108, 7241.348278654947, 7245.0, 6472.5145614080075, 6812.420944219797, 6925.6190909500465, 6954.165500140016, 7066.470014748812, 7031.191412987572, 7110.182329032021, 7143.535670181422, 7151.928480715126, 7160.8925866113095, 6162.0, 6263.123162757309, 6272.090546870587, 6308.053791931247, 6322.778702745566, 6347.5239357047485, 6388.169537960035, 6398.1362516059735, 6410.743570257324, 6433.0], "unit": "ms", "name": "mootools.html", "value": 4443.394333625616}, {"lowerIsBetter": false, "replicates": [330.48939388644544, 336.9957526570819, 363.52378384316546, 365.24212259561415, 367.23431645020133, 6386.712597933092, 6399.776007839727, 6430.839229019265, 6462.741490340387, 6576.0793488911595, 6366.108744775735, 6390.265119511258, 6390.584612000217, 6403.519736019805, 6417.711202995864, 4859.902801943959, 4860.538248866361, 4869.780859861297, 4873.0, 4874.098291816008, 4881.072596206727, 4881.877953051185, 4883.438404583483, 4886.560209581137, 4889.437714662806, 4671.929921051187, 4705.12955103307, 4809.326694262789, 4818.638602104838, 4851.369321988137, 4781.043791241731, 4803.759812009385, 4807.879803004917, 4808.0, 4814.7833347499445, 4131.462909821704, 4160.625543701081, 4161.0221597924765, 4166.312558427856, 4171.6036976487485, 6046.516278697738, 6061.575689701723, 6064.757409703607, 6069.969650151766, 6086.2958371656005, 5527.419620939783, 5549.694766787825, 5593.440655934414, 5598.44015598441, 5610.66336019836, 6700.463962882957, 6727.0, 6743.831404214934, 6751.864962700718, 6754.088198093244, 4595.356650068993, 4612.561806628365, 4613.446386433616, 4617.468991066037, 4629.560191781776, 6879.862402751917, 6951.617661028641, 7009.228984811667, 7010.0, 7050.5769653820935, 4701.318308845198, 4730.88172795676, 4740.715557066587, 4744.312074749142, 4744.908671005688, 4775.5463230993, 4795.968866693608, 4808.807647694123, 4814.085323788469, 4820.891195025164, 5583.804566840141, 5586.190002449622, 5590.944090559124, 5610.85972850682, 5634.887302253932, 6644.837153498119, 6825.1809782825385, 6860.245373008965, 6868.656567171622, 6869.381755642016, 1664.0, 1701.8978861268363, 1703.1058694185404, 1703.2250326101594, 1707.1208327711238, 1119.3339962722168, 1127.3461392392392, 1137.7895089408487, 1143.0284258380477, 1144.0733006264952, 6587.473002159912, 6639.933600664028, 6651.634160121143, 6660.267370589231, 6662.200535935719, 7063.788086357417, 7080.0, 7084.185318688416, 7084.752033678797, 7085.858282834418, 6493.837654058591, 6503.512236582275, 6564.179477565304, 6627.966860165765, 6676.666166691646, 3784.4701741756176, 3821.9617803821607, 3827.942580861289, 3830.138218900725, 3855.614438556178, 7251.492395532262, 7285.089363829521, 7293.744718934918, 7320.707171713072, 7336.303051210127, 7132.500724949204, 7283.526570772989, 7301.306375894282, 7305.707771689073, 7306.561606303639, 7309.634518274065, 7315.524490908074, 7329.413646908234, 7336.449766267551, 7338.5596864187255, 7110.253423390676, 7111.857762844611, 7116.217216106328, 7119.1457025157315, 7123.786286411416, 6766.357196066366, 6944.548604340702, 6949.409300209337, 7011.053507776385, 7040.894386584103, 7299.160596531467, 7324.19433862264, 7333.376662983706, 7337.853242935218, 7338.046054013158, 4630.953690463052, 4640.234361330343, 4644.628429725546, 4650.465196502446, 4670.906581868411, 6992.965035174791, 7141.392981596622, 7155.856882862209, 7166.104236970379, 7182.892256616259, 6979.1973922999505, 6979.755708550177, 6983.44132469391, 6983.476239281973, 6987.0, 6781.355771201728, 6911.170659520689, 6955.860882782417, 6972.233054364117, 6981.720731170696, 6762.222344430256, 6766.695498702472, 6805.9659701701175, 6824.52228344031, 6828.351306625863, 6949.548279361826, 6961.269066747918, 6968.895466568107, 6983.301669832976, 7006.0, 6636.303188165173, 6712.463002959849, 6792.762253321308, 6793.796186114425, 6819.0], "unit": "ms", "name": "prototype.html", "value": 5121.110285744015}, {"lowerIsBetter": false, "replicates": [842.5660784695881, 843.2452954605628, 872.2498651159997, 873.6505397840859, 884.1335491218606, 13501.2574308413, 13563.32183390829, 13595.728085438297, 13622.04645674802, 13633.590992270223, 13844.0, 14155.716885662281, 14188.574342769733, 14202.36089375978, 14206.0, 876.8290183414236, 915.5193523400202, 916.7249825052457, 918.1828172926067, 918.4213945214539, 868.9739307820776, 897.9673375618027, 908.6592527802075, 910.126278772376, 910.9863352049724, 954.4750387286999, 961.7451375385529, 970.9757256068619, 971.3249291742206, 971.9028097190295, 953.6185525789671, 956.4213650741306, 963.2967933408615, 964.2382517810921, 966.6809952715657, 695.655650453029, 702.0311969482133, 706.9893951590731, 707.886738121898, 707.91505019398, 14129.929350353284, 14170.291485425687, 14209.0, 14209.928950355183, 14273.072250303698, 12590.81113783294, 12872.356382180853, 13138.540151094665, 13403.329833508285, 13563.59309220725, 11257.0, 11259.774804503946, 11376.488058037408, 11475.254108482923, 11637.47631356591, 3785.3943369061094, 3833.616638336172, 3865.0, 3872.7289089763726, 4035.1324465240114, 53014.46985530134, 53507.0, 53517.73241133808, 53922.0, 53922.730386347816, 10541.84187237192, 10648.254622176373, 10724.731881702864, 11021.889781102087, 11181.0, 19273.072692730613, 19466.805331946784, 19687.212511499667, 19725.408237752603, 19736.506587335145, 8073.475224110414, 8097.554634495159, 8148.511089334659, 8194.0, 8263.132371101068, 4749.453812811502, 4799.6400269979895, 4813.78337974792, 4820.734859582686, 4912.238603016467, 3168.3980043791607, 3168.651448340681, 3172.9682703173135, 3186.139742269574, 3217.2439476722952, 580.8925348810399, 594.0346936228628, 595.3570144244293, 602.3945934335965, 603.3785201242727, 684.3464491410691, 692.5429216716942, 712.2450202784961, 713.2332742302046, 730.536109570416, 8337.624806883705, 8443.746687599381, 8637.265832404317, 8703.303735701129, 8771.692990745294, 551.4320250142359, 693.0643631097977, 704.2148004974416, 729.580491217552, 741.8182545276442, 3901.43429202764, 4247.214265360918, 4324.718893271927, 4348.978255108705, 4385.0, 65205.34794651993, 65835.34164658388, 65958.0, 66216.33783662198, 66663.33336666669, 57779.4222057774, 57781.711091444275, 58815.70592147097, 59247.0, 59399.0, 53514.464855351725, 53840.19239711407, 53891.46108538864, 54108.0, 54484.72757636187, 8723.825523489622, 8889.955550222208, 9280.164785169367, 9340.53297335144, 9375.578098985698, 36625.81687091548, 40401.79799100986, 40806.38790418087, 41457.0, 42023.0, 44957.775211123735, 48545.0, 48854.0, 50344.0, 50371.74814125906, 11461.312321260752, 11560.075193984292, 11989.820152697543, 12117.27296362221, 12193.146479746332, 12750.362481875683, 13413.061085724295, 13515.797263041259, 13695.315234238447, 14319.856801431852, 11785.469653865768, 11799.0, 12027.579034733742, 12355.876441235472, 12425.93787031059, 11541.076713863038, 11812.70468238301, 11871.169018168644, 12158.0, 12302.81545776832, 10916.64963536404, 11405.201635885409, 11567.01680357179, 12410.875891241334, 12412.193207441487, 10695.03744662984, 10791.0, 10889.618863339745, 11281.830772538255, 11352.148588855704, 9517.476538790155, 10389.84415233757, 10463.529141188512, 10578.312409693346, 10579.206559508222], "unit": "ms", "name": "yui.html", "value": 6856.0059043207075}], "name": "dromaeo_css", "value": 7445.529256620452}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 106.0, 111.0, 112.0, 112.0, 121.0, 112.0, 111.0, 110.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 111.8}, {"lowerIsBetter": true, "replicates": [151.0, 123.0, 144.0, 157.0, 123.0, 157.0, 154.0, 121.0, 159.0, 123.0], "unit": "ms", "name": "audio-beat-detection", "value": 141.2}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0, 160.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 74.0, 164.0, 73.0, 73.0, 73.0, 73.0, 173.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 92.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 132.0, 93.0, 93.0, 94.0, 137.0, 93.0, 94.0, 140.0], "unit": "ms", "name": "audio-oscillator", "value": 106.2}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 95.0, 96.0, 96.0, 98.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [59.0, 59.0, 62.0, 60.0, 59.0, 63.0, 59.0, 59.0, 58.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.5}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 65.0, 64.0, 64.0, 66.0, 66.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 65.2}, {"lowerIsBetter": true, "replicates": [86.0, 82.0, 81.0, 82.0, 84.0, 82.0, 81.0, 82.0, 83.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [113.0, 123.0, 126.0, 126.0, 113.0, 118.0, 115.0, 112.0, 122.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 119.0}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 150.0, 142.0, 158.0, 144.0, 148.0, 142.0, 135.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.8}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 66.0, 65.0, 66.0, 64.0, 65.0, 64.0, 71.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.7}], "name": "kraken", "value": 1501.6000000000001}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.5548790521639], "unit": "score", "name": "Richards", "value": 214.53025399999996}, {"lowerIsBetter": false, "replicates": [167.02856188408217], "unit": "score", "name": "DeltaBlue", "value": 395.84846600000003}, {"lowerIsBetter": false, "replicates": [278.00945232137894], "unit": "score", "name": "Encrypt", "value": 957.4530570000002}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [931.0986964618249], "unit": "score", "name": "RayTrace", "value": 794.7481860000001}, {"lowerIsBetter": false, "replicates": [544.9591280653951], "unit": "score", "name": "Earley", "value": 1222.959605}, {"lowerIsBetter": false, "replicates": [11098.901098901099], "unit": "score", "name": "Boyer", "value": 60.04765643564352}, {"lowerIsBetter": false, "replicates": [24142.85714285714], "unit": "score", "name": "RegExp", "value": 37.73310650887576}, {"lowerIsBetter": false, "replicates": [515.1983513652756], "unit": "score", "name": "Splay", "value": 158.174031}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 23256.46003602683}]} 02:44:26 INFO - RETURN: dromaeo_css: 7445.53 02:44:26 INFO - RETURN: kraken: 1501.60 02:44:26 INFO - RETURN: v8_7: 23256.46 02:44:26 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "23256.46"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1501.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7445.53"}}} 02:44:26 INFO - Return code: 0 02:44:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 02:44:26 INFO - # TBPL SUCCESS # 02:44:26 INFO - Running post-action listener: _resource_record_post_action 02:44:26 INFO - Running post-run listener: _resource_record_post_run 02:44:27 INFO - Total resource usage - Wall time: 1223s; CPU: 13.0%; Read bytes: 262144; Write bytes: 501997568; Read time: 16; Write time: 375404 02:44:27 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 236974080; Read time: 0; Write time: 241856 02:44:27 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 262144; Write bytes: 264007680; Read time: 16; Write time: 133520 02:44:27 INFO - Running post-run listener: _upload_blobber_files 02:44:27 INFO - Blob upload gear active. 02:44:27 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 02:44:27 INFO - Copying logs to upload dir... 02:44:27 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1270.703121 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2016-01-25 02:44:27.328571) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 02:44:27.332362) ========= 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=00204705a9daa57ed339a427000001b9-1453712460.489241-876706828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009992 build_url: 'https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 02:44:27.383716) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:44:27.384048) ========= 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=00204705a9daa57ed339a427000001b9-1453712460.489241-876706828 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004469 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 02:44:27.434066) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 02:44:27.434408) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 02:44:27.434719) ========= ========= Total master_lag: 0.29 =========