builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-039 starttime: 1453722372.76 results: success (0) buildid: 20160125001712 builduid: 5d8eb007e2de4c2eae63c4ce4fd78a1e revision: ab89c814f1b8a841168de98ac2679a1d66122a06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.755663) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.756035) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.756331) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006347 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.822982) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.823277) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.903687) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:12.903938) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004270 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.001509) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.001798) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.002149) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.002464) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-25 03:46:13-- 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% 220M=0s 2016-01-25 03:46:13 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.108191 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.128789) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.129062) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020084 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:13.184413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 03:46:13.184774) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-25 03:46:13,344 truncating revision to first 12 chars 2016-01-25 03:46:13,344 Setting DEBUG logging. 2016-01-25 03:46:13,344 attempt 1/10 2016-01-25 03:46:13,344 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 03:46:14,459 unpacking tar archive at: mozilla-aurora-ab89c814f1b8/testing/mozharness/ program finished with exit code 0 elapsedTime=1.436384 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-01-25 03:46:14.642882) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.643206) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False ab89c814f1b8a841168de98ac2679a1d66122a06 program finished with exit code 0 elapsedTime=0.003297 script_repo_revision: 'ab89c814f1b8a841168de98ac2679a1d66122a06' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.691683) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.691972) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-25 03:46:14.701916) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2016-01-25 03:46:14.702195) ========= /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=5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:46:14 INFO - MultiFileLogger online at 20160125 03:46:14 in /builds/slave/test-pgo 03:46:14 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 03:46:14 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:46:14 INFO - {'append_to_log': False, 03:46:14 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:46:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:46:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:46:14 INFO - 'branch': 'Mozilla-Aurora', 03:46:14 INFO - 'buildbot_json_path': 'buildprops.json', 03:46:14 INFO - 'config_files': ('talos/linux_config.py',), 03:46:14 INFO - 'default_actions': ('clobber', 03:46:14 INFO - 'read-buildbot-config', 03:46:14 INFO - 'download-and-extract', 03:46:14 INFO - 'populate-webroot', 03:46:14 INFO - 'create-virtualenv', 03:46:14 INFO - 'install', 03:46:14 INFO - 'run-tests'), 03:46:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:46:14 INFO - 'download_minidump_stackwalk': True, 03:46:14 INFO - 'download_symbols': 'ondemand', 03:46:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:46:14 INFO - 'tooltool.py': '/tools/tooltool.py', 03:46:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:46:14 INFO - '/tools/misc-python/virtualenv.py')}, 03:46:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:46:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:46:14 INFO - 'installer_path': 'installer.exe', 03:46:14 INFO - 'log_level': 'info', 03:46:14 INFO - 'log_name': 'talos', 03:46:14 INFO - 'log_to_console': True, 03:46:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:46:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:46:14 INFO - 'opt_config_files': (), 03:46:14 INFO - 'pip_index': False, 03:46:14 INFO - 'sps_profile': False, 03:46:14 INFO - 'sps_profile_interval': 0, 03:46:14 INFO - 'suite': 'dromaeojs-e10s', 03:46:14 INFO - 'system_bits': '32', 03:46:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:46:14 INFO - 'title': 'talos-linux64-ix-039', 03:46:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:46:14 INFO - 'use_talos_json': True, 03:46:14 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:46:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:46:14 INFO - 'work_dir': 'build'} 03:46:14 INFO - ##### 03:46:14 INFO - ##### Running clobber step. 03:46:14 INFO - ##### 03:46:14 INFO - Running pre-action listener: _resource_record_pre_action 03:46:14 INFO - Running main action method: clobber 03:46:14 INFO - rmtree: /builds/slave/test-pgo/build 03:46:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:46:15 INFO - Running post-action listener: _resource_record_post_action 03:46:15 INFO - ##### 03:46:15 INFO - ##### Running read-buildbot-config step. 03:46:15 INFO - ##### 03:46:15 INFO - Running pre-action listener: _resource_record_pre_action 03:46:15 INFO - Running main action method: read_buildbot_config 03:46:15 INFO - Using buildbot properties: 03:46:15 INFO - { 03:46:15 INFO - "properties": { 03:46:15 INFO - "buildnumber": 84, 03:46:15 INFO - "product": "firefox", 03:46:15 INFO - "script_repo_revision": "production", 03:46:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:46:15 INFO - "repository": "", 03:46:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:46:15 INFO - "buildid": "20160125001712", 03:46:15 INFO - "slavename": "talos-linux64-ix-039", 03:46:15 INFO - "pgo_build": "True", 03:46:15 INFO - "basedir": "/builds/slave/test-pgo", 03:46:15 INFO - "project": "", 03:46:15 INFO - "platform": "ubuntu64_hw", 03:46:15 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:46:15 INFO - "slavebuilddir": "test", 03:46:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:46:15 INFO - "branch": "mozilla-aurora", 03:46:15 INFO - "repo_path": "releases/mozilla-aurora", 03:46:15 INFO - "stage_platform": "linux64-pgo", 03:46:15 INFO - "builduid": "5d8eb007e2de4c2eae63c4ce4fd78a1e", 03:46:15 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:15 INFO - }, 03:46:15 INFO - "sourcestamp": { 03:46:15 INFO - "repository": "", 03:46:15 INFO - "hasPatch": false, 03:46:15 INFO - "project": "", 03:46:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:15 INFO - "changes": [ 03:46:15 INFO - { 03:46:15 INFO - "category": null, 03:46:15 INFO - "files": [ 03:46:15 INFO - { 03:46:15 INFO - "url": null, 03:46:15 INFO - "name": "https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2" 03:46:15 INFO - } 03:46:15 INFO - ], 03:46:15 INFO - "repository": "", 03:46:15 INFO - "rev": "ab89c814f1b8a841168de98ac2679a1d66122a06", 03:46:15 INFO - "who": "cbook@mozilla.com", 03:46:15 INFO - "when": 1453717351, 03:46:15 INFO - "number": 7510169, 03:46:15 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", 03:46:15 INFO - "project": "", 03:46:15 INFO - "at": "Mon 25 Jan 2016 02:22:31", 03:46:15 INFO - "branch": "mozilla-aurora-linux64-pgo-talos", 03:46:15 INFO - "revlink": "", 03:46:15 INFO - "properties": [ 03:46:15 INFO - [ 03:46:15 INFO - "buildid", 03:46:15 INFO - "20160125001712", 03:46:15 INFO - "Change" 03:46:15 INFO - ], 03:46:15 INFO - [ 03:46:15 INFO - "builduid", 03:46:15 INFO - "5d8eb007e2de4c2eae63c4ce4fd78a1e", 03:46:15 INFO - "Change" 03:46:15 INFO - ], 03:46:15 INFO - [ 03:46:15 INFO - "pgo_build", 03:46:15 INFO - "True", 03:46:15 INFO - "Change" 03:46:15 INFO - ] 03:46:15 INFO - ], 03:46:15 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:15 INFO - } 03:46:15 INFO - ], 03:46:15 INFO - "revision": "ab89c814f1b8a841168de98ac2679a1d66122a06" 03:46:15 INFO - } 03:46:15 INFO - } 03:46:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2. 03:46:15 INFO - Running post-action listener: _resource_record_post_action 03:46:15 INFO - ##### 03:46:15 INFO - ##### Running download-and-extract step. 03:46:15 INFO - ##### 03:46:15 INFO - Running pre-action listener: _resource_record_pre_action 03:46:15 INFO - Running main action method: download_and_extract 03:46:15 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:46:15 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')]} 03:46:15 INFO - https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:46:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 03:46:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/test_packages.json 03:46:15 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 03:46:15 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 03:46:39 INFO - Downloaded 1302 bytes. 03:46:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:46:39 INFO - Using the following test package requirements: 03:46:39 INFO - {u'common': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:39 INFO - u'cppunittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:39 INFO - u'jittest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:39 INFO - u'jsshell-linux-x86_64.zip'], 03:46:39 INFO - u'mochitest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:39 INFO - u'mozbase': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:39 INFO - u'reftest': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:46:39 INFO - u'talos': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:46:39 INFO - u'web-platform': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:39 INFO - u'webapprt': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:39 INFO - u'xpcshell': [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:39 INFO - u'firefox-45.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:39 INFO - Downloading packages: [u'firefox-45.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:39 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 03:46:39 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 03:46:39 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 03:46:39 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 03:46:39 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 03:47:09 WARNING - Timed out accessing 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: timed out 03:47:09 INFO - retry: attempt #1 caught exception: timed out 03:47:09 INFO - retry: Failed, sleeping 30 seconds before retrying 03:47:39 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 #2 03:47:42 INFO - Downloaded 23159167 bytes. 03:47:42 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 03:47:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:47:42 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 03:47:43 INFO - Return code: 0 03:47:43 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 03:47:43 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')]} 03:47:43 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 03:47:43 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 03:47:43 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 03:47:43 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 03:47:43 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 03:47:47 INFO - Downloaded 23159167 bytes. 03:47:47 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 03:47:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.common.tests.zip 03:47:47 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 03:47:49 INFO - Return code: 0 03:47: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')]} 03:47:49 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 03:47:49 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 03:47:49 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 03:47:49 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 03:47:49 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 03:47:50 INFO - Downloaded 11132038 bytes. 03:47:50 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 03:47:50 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-45.0a2.en-US.linux-x86_64.talos.tests.zip 03:47:50 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 03:47:50 INFO - Return code: 0 03:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:50 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 03:47:50 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 03:47:50 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 03:47:50 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 03:47:50 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 03:47:51 INFO - Downloaded 58033452 bytes. 03:47:51 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 03:47:51 INFO - mkdir: /builds/slave/test-pgo/properties 03:47:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:47:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:47:51 INFO - Contents: 03:47:51 INFO - build_url:https://queue.taskcluster.net/v1/task/hWuNuRHrQOytGSTwM74O8w/artifacts/public/build/firefox-45.0a2.en-US.linux-x86_64.tar.bz2 03:47:51 INFO - Running post-action listener: _resource_record_post_action 03:47:51 INFO - Running post-action listener: set_extra_try_arguments 03:47:51 INFO - ##### 03:47:51 INFO - ##### Running populate-webroot step. 03:47:51 INFO - ##### 03:47:51 INFO - Running pre-action listener: _resource_record_pre_action 03:47:51 INFO - Running main action method: populate_webroot 03:47:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:51 INFO - '--tppagecycles', 03:47:51 INFO - '7'], 03:47:51 INFO - 'tests': ['tsvgm']}}, 03:47:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:47:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:47:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:47:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:51 INFO - 'talos_options': ['--e10s'], 03:47:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:51 INFO - 'tests': ['damp', 'tps']}, 03:47:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:51 INFO - 'talos_options': ['--e10s'], 03:47:51 INFO - 'tests': ['damp', 'tps']}, 03:47:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:47:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:51 INFO - 'other': {'tests': ['a11yr', 03:47:51 INFO - 'ts_paint', 03:47:51 INFO - 'tpaint', 03:47:51 INFO - 'sessionrestore', 03:47:51 INFO - 'sessionrestore_no_auto_restore']}, 03:47:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:47:51 INFO - 'tests': ['a11yr', 03:47:51 INFO - 'ts_paint', 03:47:51 INFO - 'tpaint', 03:47:51 INFO - 'sessionrestore', 03:47:51 INFO - 'sessionrestore_no_auto_restore']}, 03:47:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:47:51 INFO - 'tests': ['a11yr', 03:47:51 INFO - 'ts_paint', 03:47:51 INFO - 'tpaint', 03:47:51 INFO - 'sessionrestore', 03:47:51 INFO - 'sessionrestore_no_auto_restore']}, 03:47:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:47:51 INFO - 'tests': ['a11yr', 03:47:51 INFO - 'ts_paint', 03:47:51 INFO - 'tpaint', 03:47:51 INFO - 'sessionrestore', 03:47:51 INFO - 'sessionrestore_no_auto_restore']}, 03:47:51 INFO - 'other_l64': {'tests': ['a11yr', 03:47:51 INFO - 'ts_paint', 03:47:51 INFO - 'tpaint', 03:47:51 INFO - 'sessionrestore', 03:47:51 INFO - 'sessionrestore_no_auto_restore']}, 03:47:51 INFO - 'other_nol64': {'tests': ['a11yr', 03:47:51 INFO - 'ts_paint', 03:47:51 INFO - 'tpaint', 03:47:51 INFO - 'sessionrestore', 03:47:51 INFO - 'sessionrestore_no_auto_restore']}, 03:47:51 INFO - 'svgr': {'tests': ['tsvgx', 03:47:51 INFO - 'tsvgr_opacity', 03:47:51 INFO - 'tart', 03:47:51 INFO - 'tscrollx', 03:47:51 INFO - 'cart']}, 03:47:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:47:51 INFO - 'tests': ['tsvgx', 03:47:51 INFO - 'tsvgr_opacity', 03:47:51 INFO - 'tart', 03:47:51 INFO - 'tscrollx', 03:47:51 INFO - 'cart']}, 03:47:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:51 INFO - 'tests': ['tp5o']}, 03:47:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:51 INFO - 'talos_options': ['--e10s'], 03:47:51 INFO - 'tests': ['tp5o']}, 03:47:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:51 INFO - 'talos_options': ['--xperf_path', 03:47:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:51 INFO - 'tests': ['tp5n']}, 03:47:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:51 INFO - 'talos_options': ['--e10s', 03:47:51 INFO - '--xperf_path', 03:47:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:51 INFO - 'tests': ['tp5n']}}, 03:47:51 INFO - 'talos.zip': {'path': '', 03:47:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:51 INFO - Running post-action listener: _resource_record_post_action 03:47:51 INFO - ##### 03:47:51 INFO - ##### Running create-virtualenv step. 03:47:51 INFO - ##### 03:47:51 INFO - Running pre-action listener: _resource_record_pre_action 03:47:51 INFO - Running main action method: create_virtualenv 03:47:51 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:47:51 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 03:47:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:47:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:52 INFO - Using real prefix '/usr' 03:47:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:47:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:54 INFO - Installing pip.................done. 03:47:54 INFO - Return code: 0 03:47:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:47:54 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')]} 03:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:54 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')]} 03:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:54 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 0x7fc313153f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', '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 03:47:54 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 03:47:54 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 03:47:54 INFO - Using env: {'DISPLAY': ':0', 03:47:54 INFO - 'HOME': '/home/cltbld', 03:47:54 INFO - 'LANG': 'en_US.UTF-8', 03:47:54 INFO - 'LANGUAGE': 'en_US:en', 03:47:54 INFO - 'LOGNAME': 'cltbld', 03:47:54 INFO - 'MAIL': '/var/mail/cltbld', 03:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:54 INFO - 'MOZ_NO_REMOTE': '1', 03:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:54 INFO - 'NO_EM_RESTART': '1', 03:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:54 INFO - 'SHELL': '/bin/bash', 03:47:54 INFO - 'SHLVL': '1', 03:47:54 INFO - 'TERM': 'linux', 03:47:54 INFO - 'TMOUT': '86400', 03:47:54 INFO - 'USER': 'cltbld', 03:47:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:54 INFO - '_': '/tools/buildbot/bin/python'} 03:47:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:54 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 03:47:54 INFO - Cleaning up... 03:47:54 INFO - Return code: 0 03:47:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:47:54 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')]} 03:47:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:54 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')]} 03:47:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:54 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 0x7fc313153f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', '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 03:47:54 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 03:47:54 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 03:47:54 INFO - Using env: {'DISPLAY': ':0', 03:47:54 INFO - 'HOME': '/home/cltbld', 03:47:54 INFO - 'LANG': 'en_US.UTF-8', 03:47:54 INFO - 'LANGUAGE': 'en_US:en', 03:47:54 INFO - 'LOGNAME': 'cltbld', 03:47:54 INFO - 'MAIL': '/var/mail/cltbld', 03:47:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:54 INFO - 'MOZ_NO_REMOTE': '1', 03:47:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:54 INFO - 'NO_EM_RESTART': '1', 03:47:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:54 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:54 INFO - 'SHELL': '/bin/bash', 03:47:54 INFO - 'SHLVL': '1', 03:47:54 INFO - 'TERM': 'linux', 03:47:54 INFO - 'TMOUT': '86400', 03:47:54 INFO - 'USER': 'cltbld', 03:47:54 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:47:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:54 INFO - '_': '/tools/buildbot/bin/python'} 03:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:55 INFO - Downloading/unpacking psutil>=0.7.1 03:47:55 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 03:47:55 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 03:47:55 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 03:47:55 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 03:47:55 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 03:47:55 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 03:47:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:56 INFO - Installing collected packages: psutil 03:47:56 INFO - Running setup.py install for psutil 03:47:57 INFO - building 'psutil._psutil_linux' extension 03:47:57 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 03:47:57 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 03:47:57 INFO - building 'psutil._psutil_posix' extension 03:47:57 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 03:47:57 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 03:47:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:57 INFO - Successfully installed psutil 03:47:57 INFO - Cleaning up... 03:47:57 INFO - Return code: 0 03:47:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:47: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')]} 03:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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')]} 03:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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', '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 0x7fc313153f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', '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 03:47: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:47: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 mozsystemmonitor==0.0.0 03:47:57 INFO - Using env: {'DISPLAY': ':0', 03:47:57 INFO - 'HOME': '/home/cltbld', 03:47:57 INFO - 'LANG': 'en_US.UTF-8', 03:47:57 INFO - 'LANGUAGE': 'en_US:en', 03:47:57 INFO - 'LOGNAME': 'cltbld', 03:47:57 INFO - 'MAIL': '/var/mail/cltbld', 03:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:57 INFO - 'MOZ_NO_REMOTE': '1', 03:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:57 INFO - 'NO_EM_RESTART': '1', 03:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:57 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:57 INFO - 'SHELL': '/bin/bash', 03:47:57 INFO - 'SHLVL': '1', 03:47:57 INFO - 'TERM': 'linux', 03:47:57 INFO - 'TMOUT': '86400', 03:47:57 INFO - 'USER': 'cltbld', 03:47:57 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:57 INFO - '_': '/tools/buildbot/bin/python'} 03:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:47:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:47:59 INFO - Installing collected packages: mozsystemmonitor 03:47:59 INFO - Running setup.py install for mozsystemmonitor 03:47:59 INFO - Successfully installed mozsystemmonitor 03:47:59 INFO - Cleaning up... 03:47:59 INFO - Return code: 0 03:47:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:47: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')]} 03:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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')]} 03:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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', '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 0x7fc313153f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', '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 03:47: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:47: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 blobuploader==1.2.4 03:47:59 INFO - Using env: {'DISPLAY': ':0', 03:47:59 INFO - 'HOME': '/home/cltbld', 03:47:59 INFO - 'LANG': 'en_US.UTF-8', 03:47:59 INFO - 'LANGUAGE': 'en_US:en', 03:47:59 INFO - 'LOGNAME': 'cltbld', 03:47:59 INFO - 'MAIL': '/var/mail/cltbld', 03:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:59 INFO - 'MOZ_NO_REMOTE': '1', 03:47:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:59 INFO - 'NO_EM_RESTART': '1', 03:47:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:47:59 INFO - 'PWD': '/builds/slave/test-pgo', 03:47:59 INFO - 'SHELL': '/bin/bash', 03:47:59 INFO - 'SHLVL': '1', 03:47:59 INFO - 'TERM': 'linux', 03:47:59 INFO - 'TMOUT': '86400', 03:47:59 INFO - 'USER': 'cltbld', 03:47:59 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:59 INFO - '_': '/tools/buildbot/bin/python'} 03:47:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:47: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 03:48:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:48:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48: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 03:48:01 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:48:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:02 INFO - Downloading docopt-0.6.1.tar.gz 03:48:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:48:02 INFO - Installing collected packages: blobuploader, requests, docopt 03:48:02 INFO - Running setup.py install for blobuploader 03:48:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:48:02 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:48:02 INFO - Running setup.py install for requests 03:48:02 INFO - Running setup.py install for docopt 03:48:02 INFO - Successfully installed blobuploader requests docopt 03:48:02 INFO - Cleaning up... 03:48:02 INFO - Return code: 0 03:48:02 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48:02 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')]} 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:02 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')]} 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:02 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 0x7fc313153f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', '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 03:48:02 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 03:48:02 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 03:48:02 INFO - Using env: {'DISPLAY': ':0', 03:48:02 INFO - 'HOME': '/home/cltbld', 03:48:02 INFO - 'LANG': 'en_US.UTF-8', 03:48:02 INFO - 'LANGUAGE': 'en_US:en', 03:48:02 INFO - 'LOGNAME': 'cltbld', 03:48:02 INFO - 'MAIL': '/var/mail/cltbld', 03:48:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:02 INFO - 'MOZ_NO_REMOTE': '1', 03:48:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:02 INFO - 'NO_EM_RESTART': '1', 03:48:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:02 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:02 INFO - 'SHELL': '/bin/bash', 03:48:02 INFO - 'SHLVL': '1', 03:48:02 INFO - 'TERM': 'linux', 03:48:02 INFO - 'TMOUT': '86400', 03:48:02 INFO - 'USER': 'cltbld', 03:48:02 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:48:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:02 INFO - '_': '/tools/buildbot/bin/python'} 03:48:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:03 INFO - Running setup.py (path:/tmp/pip-wLLPtH-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:03 INFO - Running setup.py (path:/tmp/pip-MwCLGl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:03 INFO - Running setup.py (path:/tmp/pip-_pmhA1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:03 INFO - Running setup.py (path:/tmp/pip-TLlPJw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:03 INFO - Running setup.py (path:/tmp/pip-cRhnjp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:03 INFO - Running setup.py (path:/tmp/pip-rxOid_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:03 INFO - Running setup.py (path:/tmp/pip-5S1rS9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:03 INFO - Running setup.py (path:/tmp/pip-VQLcdN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:03 INFO - Running setup.py (path:/tmp/pip-QSp09U-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:03 INFO - Running setup.py (path:/tmp/pip-mgPmFg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:03 INFO - Running setup.py (path:/tmp/pip-OMrPqN-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:03 INFO - Running setup.py (path:/tmp/pip-QbRpz1-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:04 INFO - Running setup.py (path:/tmp/pip-jBaQ1_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:04 INFO - Running setup.py (path:/tmp/pip-Yd75YE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:04 INFO - Running setup.py (path:/tmp/pip-Ao9q5K-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:04 INFO - Running setup.py (path:/tmp/pip-dPeLF7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:04 INFO - Running setup.py (path:/tmp/pip-g4iXUm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:48:04 INFO - Running setup.py install for manifestparser 03:48:04 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Running setup.py install for mozcrash 03:48:04 INFO - Running setup.py install for mozdebug 03:48:04 INFO - Running setup.py install for mozdevice 03:48:04 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:48:04 INFO - Running setup.py install for mozfile 03:48:04 INFO - Running setup.py install for mozhttpd 03:48:05 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozinfo 03:48:05 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozInstall 03:48:05 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozleak 03:48:05 INFO - Running setup.py install for mozlog 03:48:05 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for moznetwork 03:48:05 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozprocess 03:48:05 INFO - Running setup.py install for mozprofile 03:48:05 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozrunner 03:48:05 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:48:05 INFO - Running setup.py install for mozscreenshot 03:48:05 INFO - Running setup.py install for moztest 03:48:06 INFO - Running setup.py install for mozversion 03:48:06 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:48:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:06 INFO - Cleaning up... 03:48:06 INFO - Return code: 0 03:48:06 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:06 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 0x7fc313153f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', '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 03:48:06 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 03:48:06 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 03:48:06 INFO - Using env: {'DISPLAY': ':0', 03:48:06 INFO - 'HOME': '/home/cltbld', 03:48:06 INFO - 'LANG': 'en_US.UTF-8', 03:48:06 INFO - 'LANGUAGE': 'en_US:en', 03:48:06 INFO - 'LOGNAME': 'cltbld', 03:48:06 INFO - 'MAIL': '/var/mail/cltbld', 03:48:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:06 INFO - 'MOZ_NO_REMOTE': '1', 03:48:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:06 INFO - 'NO_EM_RESTART': '1', 03:48:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:06 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:06 INFO - 'SHELL': '/bin/bash', 03:48:06 INFO - 'SHLVL': '1', 03:48:06 INFO - 'TERM': 'linux', 03:48:06 INFO - 'TMOUT': '86400', 03:48:06 INFO - 'USER': 'cltbld', 03:48:06 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:48:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:06 INFO - '_': '/tools/buildbot/bin/python'} 03:48:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:06 INFO - Running setup.py (path:/tmp/pip-jJToEL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:06 INFO - Running setup.py (path:/tmp/pip-UpSedP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:06 INFO - Running setup.py (path:/tmp/pip-slmmiC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:06 INFO - Running setup.py (path:/tmp/pip-49e1P6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:06 INFO - Running setup.py (path:/tmp/pip-dGJOc9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:06 INFO - Running setup.py (path:/tmp/pip-3wi3GK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:06 INFO - Running setup.py (path:/tmp/pip-iQxHGS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:48:06 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)) 03:48:06 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:06 INFO - Running setup.py (path:/tmp/pip-A8mEv_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:07 INFO - Running setup.py (path:/tmp/pip-QRYezU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:07 INFO - Running setup.py (path:/tmp/pip-RNFwsA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:07 INFO - Running setup.py (path:/tmp/pip-tP5yxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:07 INFO - Running setup.py (path:/tmp/pip-rb_OPY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:07 INFO - Running setup.py (path:/tmp/pip-gtQS9a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:07 INFO - Running setup.py (path:/tmp/pip-CetC0s-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:07 INFO - Running setup.py (path:/tmp/pip-5xy2Sv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:07 INFO - Running setup.py (path:/tmp/pip-XEe5pW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:48:07 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)) 03:48:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:07 INFO - Running setup.py (path:/tmp/pip-PeljUf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 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)) 03:48:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:07 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 03:48:07 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 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:09 INFO - Downloading blessings-1.6.tar.gz 03:48:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:09 INFO - Installing collected packages: blessings 03:48:09 INFO - Running setup.py install for blessings 03:48:09 INFO - Successfully installed blessings 03:48:09 INFO - Cleaning up... 03:48:09 INFO - Return code: 0 03:48:09 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:48:09 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:48:09 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:48:09 INFO - Reading from file tmpfile_stdout 03:48:09 INFO - Current package versions: 03:48:09 INFO - argparse == 1.2.1 03:48:09 INFO - blessings == 1.6 03:48:09 INFO - blobuploader == 1.2.4 03:48:09 INFO - docopt == 0.6.1 03:48:09 INFO - manifestparser == 1.1 03:48:09 INFO - mozInstall == 1.12 03:48:09 INFO - mozcrash == 0.16 03:48:09 INFO - mozdebug == 0.1 03:48:09 INFO - mozdevice == 0.47 03:48:09 INFO - mozfile == 1.2 03:48:09 INFO - mozhttpd == 0.7 03:48:09 INFO - mozinfo == 0.9 03:48:09 INFO - mozleak == 0.1 03:48:09 INFO - mozlog == 3.1 03:48:09 INFO - moznetwork == 0.27 03:48:09 INFO - mozprocess == 0.22 03:48:09 INFO - mozprofile == 0.27 03:48:09 INFO - mozrunner == 6.11 03:48:09 INFO - mozscreenshot == 0.1 03:48:09 INFO - mozsystemmonitor == 0.0 03:48:09 INFO - moztest == 0.7 03:48:09 INFO - mozversion == 1.4 03:48:09 INFO - psutil == 3.1.1 03:48:09 INFO - requests == 1.2.3 03:48:09 INFO - wsgiref == 0.1.2 03:48:09 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:09 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 0x7fc313153f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', '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 03:48:09 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 03:48:09 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 03:48:09 INFO - Using env: {'DISPLAY': ':0', 03:48:09 INFO - 'HOME': '/home/cltbld', 03:48:09 INFO - 'LANG': 'en_US.UTF-8', 03:48:09 INFO - 'LANGUAGE': 'en_US:en', 03:48:09 INFO - 'LOGNAME': 'cltbld', 03:48:09 INFO - 'MAIL': '/var/mail/cltbld', 03:48:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:09 INFO - 'MOZ_NO_REMOTE': '1', 03:48:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:09 INFO - 'NO_EM_RESTART': '1', 03:48:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:09 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:09 INFO - 'SHELL': '/bin/bash', 03:48:09 INFO - 'SHLVL': '1', 03:48:09 INFO - 'TERM': 'linux', 03:48:09 INFO - 'TMOUT': '86400', 03:48:09 INFO - 'USER': 'cltbld', 03:48:09 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:48:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:09 INFO - '_': '/tools/buildbot/bin/python'} 03:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 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)) 03:48:10 INFO - Cleaning up... 03:48:10 INFO - Return code: 0 03:48:10 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:48:10 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')]} 03:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 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')]} 03:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:10 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 0x7fc313153f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', '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 03:48:10 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 03:48:10 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 03:48:10 INFO - Using env: {'DISPLAY': ':0', 03:48:10 INFO - 'HOME': '/home/cltbld', 03:48:10 INFO - 'LANG': 'en_US.UTF-8', 03:48:10 INFO - 'LANGUAGE': 'en_US:en', 03:48:10 INFO - 'LOGNAME': 'cltbld', 03:48:10 INFO - 'MAIL': '/var/mail/cltbld', 03:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:10 INFO - 'MOZ_NO_REMOTE': '1', 03:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:10 INFO - 'NO_EM_RESTART': '1', 03:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:10 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:10 INFO - 'SHELL': '/bin/bash', 03:48:10 INFO - 'SHLVL': '1', 03:48:10 INFO - 'TERM': 'linux', 03:48:10 INFO - 'TMOUT': '86400', 03:48:10 INFO - 'USER': 'cltbld', 03:48:10 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:10 INFO - '_': '/tools/buildbot/bin/python'} 03:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:10 INFO - Downloading/unpacking jsonschema 03:48:10 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 03:48:10 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 03:48:10 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 03:48:10 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 03:48:10 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 03:48:10 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 03:48:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:12 INFO - Downloading/unpacking functools32 (from jsonschema) 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:12 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:12 INFO - warning: no files found matching '*.txt' 03:48:12 INFO - no previously-included directories found matching 'build' 03:48:12 INFO - no previously-included directories found matching 'dist' 03:48:12 INFO - no previously-included directories found matching '.git*' 03:48:12 INFO - Installing collected packages: jsonschema, functools32 03:48:12 INFO - Running setup.py install for functools32 03:48:12 INFO - warning: no files found matching '*.txt' 03:48:12 INFO - no previously-included directories found matching 'build' 03:48:12 INFO - no previously-included directories found matching 'dist' 03:48:12 INFO - no previously-included directories found matching '.git*' 03:48:12 INFO - Successfully installed jsonschema functools32 03:48:12 INFO - Cleaning up... 03:48:12 INFO - Return code: 0 03:48:12 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:12 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 0x7fc313153f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x181f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18ed450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, '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': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', '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 03:48:12 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 03:48:12 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 03:48:12 INFO - Using env: {'DISPLAY': ':0', 03:48:12 INFO - 'HOME': '/home/cltbld', 03:48:12 INFO - 'LANG': 'en_US.UTF-8', 03:48:12 INFO - 'LANGUAGE': 'en_US:en', 03:48:12 INFO - 'LOGNAME': 'cltbld', 03:48:12 INFO - 'MAIL': '/var/mail/cltbld', 03:48:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:12 INFO - 'MOZ_NO_REMOTE': '1', 03:48:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:12 INFO - 'NO_EM_RESTART': '1', 03:48:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:12 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:12 INFO - 'SHELL': '/bin/bash', 03:48:12 INFO - 'SHLVL': '1', 03:48:12 INFO - 'TERM': 'linux', 03:48:12 INFO - 'TMOUT': '86400', 03:48:12 INFO - 'USER': 'cltbld', 03:48:12 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:48:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:12 INFO - '_': '/tools/buildbot/bin/python'} 03:48:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:12 INFO - Downloading/unpacking flake8 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:48:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:48:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:15 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:15 INFO - no previously-included directories found matching 'docs/_build' 03:48:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:48:15 INFO - Running setup.py install for pep8 03:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:48:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:48:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:48:15 INFO - no previously-included directories found matching 'docs/_build' 03:48:15 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:48:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:48:15 INFO - Cleaning up... 03:48:15 INFO - Return code: 0 03:48:15 INFO - Running post-action listener: _resource_record_post_action 03:48:15 INFO - Running post-action listener: _start_resource_monitoring 03:48:15 INFO - Starting resource monitoring. 03:48:15 INFO - ##### 03:48:15 INFO - ##### Running install step. 03:48:15 INFO - ##### 03:48:15 INFO - Running pre-action listener: _resource_record_pre_action 03:48:15 INFO - Running main action method: install 03:48:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:48:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:48:15 INFO - Reading from file tmpfile_stdout 03:48:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:15 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:48:15 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:48:15 INFO - Reading from file tmpfile_stdout 03:48:15 INFO - Output received: 03:48:15 INFO - Usage: mozinstall [options] installer 03:48:15 INFO - Options: 03:48:15 INFO - -h, --help show this help message and exit 03:48:15 INFO - -d DEST, --destination=DEST 03:48:15 INFO - Directory to install application into. [default: 03:48:15 INFO - "/builds/slave/test-pgo"] 03:48:15 INFO - --app=APP Application being installed. [default: firefox] 03:48:15 INFO - mkdir: /builds/slave/test-pgo/build/application 03:48:15 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'] 03:48:15 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 03:48:30 INFO - Reading from file tmpfile_stdout 03:48:30 INFO - Output received: 03:48:30 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:48:30 INFO - Running post-action listener: _resource_record_post_action 03:48:30 INFO - ##### 03:48:30 INFO - ##### Running run-tests step. 03:48:30 INFO - ##### 03:48:30 INFO - Running pre-action listener: _resource_record_pre_action 03:48:30 INFO - Running main action method: run_tests 03:48:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:48:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:48:30 INFO - Python 2.7.3 03:48:30 INFO - Return code: 0 03:48:30 INFO - grabbing minidump binary from tooltool 03:48:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:30 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 0x197fa50>, '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 0x18eb550>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18eb9e0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:48:30 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 03:48:30 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 03:48:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:30 INFO - Return code: 0 03:48:30 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:48:30 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:48:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:48:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:48:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:48:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:48:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:48:31 INFO - Return code: 0 03:48:31 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-039', '--webServer', 'localhost'] in /builds/slave/test-pgo/build 03:48:31 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-039 --webServer localhost 03:48:31 INFO - Using env: {'DISPLAY': ':0', 03:48:31 INFO - 'HOME': '/home/cltbld', 03:48:31 INFO - 'LANG': 'en_US.UTF-8', 03:48:31 INFO - 'LANGUAGE': 'en_US:en', 03:48:31 INFO - 'LOGNAME': 'cltbld', 03:48:31 INFO - 'MAIL': '/var/mail/cltbld', 03:48:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:48:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:31 INFO - 'MOZ_NO_REMOTE': '1', 03:48:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:31 INFO - 'NO_EM_RESTART': '1', 03:48:31 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:48:31 INFO - 'PWD': '/builds/slave/test-pgo', 03:48:31 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:48:31 INFO - 'SHELL': '/bin/bash', 03:48:31 INFO - 'SHLVL': '1', 03:48:31 INFO - 'TERM': 'linux', 03:48:31 INFO - 'TMOUT': '86400', 03:48:31 INFO - 'USER': 'cltbld', 03:48:31 INFO - 'XDG_SESSION_COOKIE': '5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468', 03:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:31 INFO - '_': '/tools/buildbot/bin/python'} 03:48:31 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-039', '--webServer', 'localhost'] with output_timeout 3600 03:48:31 INFO - mozversion INFO | application_buildid: 20160125001712 03:48:31 INFO - mozversion INFO | application_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 03:48:31 INFO - mozversion INFO | application_display_name: FirefoxDeveloperEdition 03:48:31 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:31 INFO - mozversion INFO | application_name: Firefox 03:48:31 INFO - mozversion INFO | application_remotingname: firefox-dev 03:48:31 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:48:31 INFO - mozversion INFO | application_vendor: Mozilla 03:48:31 INFO - mozversion INFO | application_version: 45.0a2 03:48:31 INFO - mozversion INFO | platform_buildid: 20160125001712 03:48:31 INFO - mozversion INFO | platform_changeset: ab89c814f1b8a841168de98ac2679a1d66122a06 03:48:31 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:48:31 INFO - mozversion INFO | platform_version: 45.0a2 03:48:31 INFO - 2016-01-25 03:48:31,645 DEBUG : using testdate: 1453722511 03:48:31 INFO - 2016-01-25 03:48:31,645 DEBUG : actual date: 1453722511 03:48:31 INFO - 2016-01-25 03:48:31,654 INFO : starting webserver on 'localhost:48091' 03:48:31 INFO - 2016-01-25 03:48:31,655 INFO : Starting test suite talos-linux64-ix-039.e 03:48:31 INFO - 2016-01-25 03:48:31,655 INFO : Starting test dromaeo_css 03:48:31 INFO - 2016-01-25 03:48:31,655 DEBUG : operating with platform_type : linux_ 03:48:31 INFO - 2016-01-25 03:48:31,656 INFO : Initialising browser for dromaeo_css test... 03:48:31 INFO - 2016-01-25 03:48:31,672 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnCfcIr/profile http://localhost:48091/getInfo.html 03:48:35 INFO - 2016-01-25 03:48:35,513 DEBUG : BROWSER_OUTPUT: 03:48:35 INFO - 2016-01-25 03:48:35,514 DEBUG : BROWSER_OUTPUT: (process:6168): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:48:36 INFO - 2016-01-25 03:48:36,438 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:48:36 INFO - 2016-01-25 03:48:36,438 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:48:36 INFO - 2016-01-25 03:48:36,438 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:48:36 INFO - 2016-01-25 03:48:36,438 DEBUG : BROWSER_OUTPUT: __metrics 03:48:37 INFO - 2016-01-25 03:48:37,421 INFO : Browser initialized. 03:48:37 INFO - 2016-01-25 03:48:37,422 INFO : Running cycle 1/1 for dromaeo_css test... 03:48:37 INFO - 2016-01-25 03:48:37,422 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnCfcIr/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:48:38 INFO - 2016-01-25 03:48:38,764 DEBUG : BROWSER_OUTPUT: 03:48:38 INFO - 2016-01-25 03:48:38,764 DEBUG : BROWSER_OUTPUT: (process:6283): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:48:49 INFO - 2016-01-25 03:48:49,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 136376320 03:48:49 INFO - 2016-01-25 03:48:49,268 DEBUG : BROWSER_OUTPUT: 03:49:38 INFO - 2016-01-25 03:49:38,879 DEBUG : BROWSER_OUTPUT: 1453722578873 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] 03:51:47 INFO - 2016-01-25 03:51:47,179 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48091/tests/dromaeo/cssquery-ext.html) 03:51:48 INFO - 2016-01-25 03:51:48,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 140312576 03:51:48 INFO - 2016-01-25 03:51:48,204 DEBUG : BROWSER_OUTPUT: 03:54:50 INFO - 2016-01-25 03:54:50,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-ext.html (next: http://localhost:48091/tests/dromaeo/cssquery-jquery.html) 03:54:50 INFO - 2016-01-25 03:54:50,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 139341824 03:54:50 INFO - 2016-01-25 03:54:50,592 DEBUG : BROWSER_OUTPUT: 03:57:52 INFO - 2016-01-25 03:57:52,144 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48091/tests/dromaeo/cssquery-mootools.html) 03:57:52 INFO - 2016-01-25 03:57:52,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 138240000 03:57:52 INFO - 2016-01-25 03:57:52,732 DEBUG : BROWSER_OUTPUT: 04:00:54 INFO - 2016-01-25 04:00:54,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48091/tests/dromaeo/cssquery-prototype.html) 04:00:54 INFO - 2016-01-25 04:00:54,912 DEBUG : BROWSER_OUTPUT: RSS: Main: 137719808 04:00:54 INFO - 2016-01-25 04:00:54,912 DEBUG : BROWSER_OUTPUT: 04:03:57 INFO - 2016-01-25 04:03:57,210 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48091/tests/dromaeo/cssquery-yui.html) 04:03:57 INFO - 2016-01-25 04:03:57,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 139689984 04:03:57 INFO - 2016-01-25 04:03:57,796 DEBUG : BROWSER_OUTPUT: 04:06:59 INFO - 2016-01-25 04:06:59,824 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/dromaeo/cssquery-yui.html (next: http://localhost:48091/tests/dromaeo/cssquery-dojo.html) 04:07:00 INFO - 2016-01-25 04:07:00,070 DEBUG : BROWSER_OUTPUT: RSS: Main: 142315520 04:07:00 INFO - 2016-01-25 04:07:00,070 DEBUG : BROWSER_OUTPUT: 04:07:00 INFO - 2016-01-25 04:07:00,071 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:00 INFO - 2016-01-25 04:07:00,071 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:00 INFO - 2016-01-25 04:07:00,071 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:00 INFO - 2016-01-25 04:07:00,071 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:00 INFO - 2016-01-25 04:07:00,073 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3357.9999999999986;3381.340638575478;3382.3066271414364;3394.6096198937116;3414.7780394274355;5574.721263936807;5609.803656872005;5610.69141197234;5611.915821262679;5615.270014898063;5557.221988921544;5603.579731520143;5604.495595396414;5609.411011843759;5647.491725744682;5075.7715902784275;5089.872753181163;5134.512221338967;5181.533661970422;5183.974080129594;5026.849194524152;5046.596272298226;5115.130427827278;5116.923246151292;5131.1277082895995;5050.823221187259;5124.231365295217;5129.2562578426105;5142.537171654551;5181.1710126379785;5119.334486516729;5119.46582953385;5126.820561280375;5143.922841157367;5156.793728250866;4824.903501929977;4907.141250281186;4993.975030124826;5088.720120393377;5106.336176297094;5469.644473109235;5505.532029777473;5513.862153446155;5519.420460851593;5572.916406253909;6112.633242005494;6137.079438084278;6139.754409823602;6185.226846644169;6193.752249909998;5888.5877988540815;6005.579609427342;6016.8194954151;6100.23747031621;6196.101565273055;5745.368009518949;5747.39652336507;5768.192453056576;5775.8556036099435;5777.480026797609;6212.689365531705;6218.098375735493;6243.282022567463;6244.219472565929;6249.687515624291;5777.913331300034;5876.1479585459865;5968.37332080134;6014.188084608521;6080.361562036011;6147.631142131487;6149.877002459926;6161.6611086389785;6164.260288765287;6171.814845554641;5786.797462088806;6039.849003774941;6052.54605904559;6097.3292937776805;6104.298005729398;5812.215350927655;5942.673152976541;6086.817395478142;6126.326104128542;6191.659458729723;4657.46439159501;4659.720416774937;4669.813207471731;4685.601723853442;4693.178693728584;4100.2414553307735;4166.479190101238;4173.8956526087095;4178.289690752579;4189.413482112506;5753.223314852525;5774.133879918046;5778.451047150598;5808.6224395414165;5868.295804503487;6082.391760823971;6143.784967526115;6166.568340216231;6173.41352571505;6190.0405437157315;5585.162225666101;5714;5788.3343415506915;5862.530997520188;5871.588988770745;5150.356205474316;5179.689218646893;5200.713960732196;5210.5831533477985;5255.395629502656;6212.9068063979075;6270.2789179244055;6272.341404152589;6320.747170113144;6342.841428964312;6150.630962142286;6171.84570385744;6182.814515564451;6184.474319682698;6187.071939209155;5988.610740301867;6027.397260273938;6214.40963108504;6302.779402720883;6388.712507937061;6050;6052.727627256696;6080.568531161388;6089.117078023751;6131.386861314011;6157.415045570664;6173.38003502632;6185.474234689922;6188.783392581238;6209.720562574786;5678.801241956512;5852.795152169653;5916.437938395846;5997.5501837363245;6037.577369584263;5971.7611295547695;6005.7297421617;6010.218671572842;6012.098185272244;6044.335123136363;5669.886602268014;5871.530277577869;5877.882442351043;5880.411958804086;5899.823005309848;5897.616654917417;5929.555283353852;6010.609310394811;6034.788782392595;6035.818925432244;5761.740721667619;5789.421057894177;5816.883662326645;5840.065589505659;5877.706114694333 04:07:00 INFO - 2016-01-25 04:07:00,074 DEBUG : BROWSER_OUTPUT: |1;ext.html;621.2731104607609;621.7937201828454;622.3496446213703;626.5958456795368;674.585130144961;40224.39663405048;40904.386434203436;40913.79543102284;41075.79462102693;41126.17747645045;42349.7882510587;43081.784591077;43084.56915430845;43128.78435607818;43175.78412107935;8863.423877447978;9015.95492022539;9066.592003359865;9068.229200517932;9090.272778177763;8826.911730882674;8893.73318800437;8921.197092261695;8958.32812539059;8962.596683149273;8828.955855220715;8946.64213431462;8973.327000474957;8977.685780997666;8986.281097512216;8929.821403571925;8994.730158095268;9026;9043.909560904372;9047.457152570867;8659.567021648956;8838;8844.071372505923;8857.20285174331;8859.468431894042;38667.22665546701;39016.414753778714;39293.21413571713;39299.8035009826;39330;3614.945775813365;3662.176010397666;3711.536057992751;3723.94414083789;3767.2088861339153;31938.840305798556;32264.838675806706;32284.6771532284;32421.351572968644;32605;3691.077230692327;3708.8145592720257;3724.16206353571;3773.792441415721;3796.791176485292;285866;285974;286115.56942215364;286320;288566;44503.33245001327;45389.77305113519;45470.31794523085;60588;61367;43786.56213437889;43891;43964.78017609892;43988.78005609952;44015;15014.924925375302;15221.6194595136;15252.923735381251;15277.6180595486;15299.311530980909;11906.821397678868;12016.579419720269;12068.698282542831;12112.39438028095;12136.45385957634;15408.229588520753;15428.305726242346;15490.767638485431;15501.147436890853;15539.922300388653;6101.542384321105;6253.343398943045;6356.555041147075;6390.233172019387;6391.488680905516;988.4020167798523;996.8255555277798;1005.1857995024054;1023.8515415264745;1065.408698172506;30210.697893021228;30664;30902.86943831542;30960.535591966138;31450.528242076387;1141.3323205924628;1161.895429411357;1199.2264989081993;1217.7625363054296;1219.9024078073733;16112.597185070466;16135.83864161367;16176.676466470604;16281.348746050262;16363.100029498491;543055;544527;550373;552062;835220;58067.70966145227;58379.4162058374;58776.70611647;58886.41113588895;58890.41109588935;1438.3743071763815;1443.1846007006009;1450.9419623214953;1451.7677171652697;1462.1884853906183;29967.605830949768;30194.69805301919;30958.53562196524;30985.380292394475;31255.374892501568;47690;47930.520694792605;48215.27677084776;48461.75769121132;48564.51435485741;314764;316530;317788;318630;318671;34222.31555368929;34261.31477370389;34497.65502344944;34560.82719586386;34648.82675586606;45035;45505;45601.77199113983;54619.45380546144;55237;39356.409653854644;39373.409398859614;39577;39652.80173599113;40451.797741011105;39407.80296098501;39789.2042159161;43018;44522.77738611286;45235.54764452445;38441.4233786499;38773.41839872461;38885.41671874981;38918.80540597279;38943.805280973414;32890.83554582212;33714.83142584271;34049.82975085208;34306.14234644154;37704.622953771206;26004.34989125287;27154.864225678746;29822.55266170966;30567.2358191047;30632.540511891893 04:07:00 INFO - 2016-01-25 04:07:00,075 DEBUG : BROWSER_OUTPUT: |2;jquery.html;369.9704023678106;380.22054787685255;380.3799806315705;380.61367711772544;385.1180795977211;15646.765298520502;16998.575035624115;18472.907635461837;19262.5184370391;19307.227710891566;17600.823991760077;17860.374886878963;18053.097345132755;18446.723299150523;18470.815291847077;5440.564754819615;5588.580856435763;5626.099824028156;5627.493525582697;5631.2960879890015;5174.818881339153;5305.230741542474;5367.516923476886;5382.381026181981;5541.6674999499955;5256.763445644955;5290;5290.232916227144;5334.439883812202;5456.727163641822;5519.668819870801;5526.392096869341;5559.416261292547;5561.304836895388;5584.246126772895;5282.049231138393;5371.57027437804;5398.865028374283;5405.054115529767;5445;13303.53437629688;13431.798523022162;13462.865371346259;16859.494215173563;22395.55208895829;2173.0655817998254;2245.764194759543;2311.0871205873755;2337.207102241602;2356.4580146566213;9879.86381566122;10034.69895903124;10431.739206519822;11621.767564648744;13266.270355130464;1969.222157247879;2014.909329080195;2025.6758918573105;2068.617305798432;2071.1301253473425;64247.3575264246;65954.3404565953;66912;67493.32506674969;67509.66245168792;10609.363438193734;10927.836082458769;11014.889851101547;11115.666530004113;11160.441977901073;14291.92854035744;14331.928340358232;14338.713225735635;14342.569722908329;14347;7602.46782725204;7642.426817988673;7690.769276921701;7732.4200684948855;7777.144514103444;7384.889226661604;7676.347510461674;7702.96148519265;7710.306072453506;7721.498102623312;4681.227597446383;4713;4728.88177795551;4763.071201115749;4777.95222047782;1954.7458830351964;1957.5791204891016;1960.1767257751778;1961.08809403628;1991.5618563915916;440.2252036415867;445.97547134907893;959.2517836087862;1020.2399212586522;1104.5581767293147;11019.393933333584;11337.886621133848;11439.51286332788;11492;11648.53405863773;453.8456924645636;454.01931827252974;474.58948009971124;475.67416319821035;481.9783109760069;6071.453569178795;6199.628022318585;6199.659018754011;6204.410580994799;6266.686665666698;612769;626630;633496;635957;658020;86968.56515717508;87191.56404217938;87946.56026719825;88713;89360.5531972336;509.8827269727983;516.246280430568;516.6770768269831;516.8036146264395;518.0959226150392;10548.736281593021;10629.342664333917;10648.89351106479;10723.30298530593;10733.98027187416;36361.63638363582;37093.25813483769;37121;37445.81277093597;37620.811895940344;51764;52521.21218181807;52748.20877686914;53332;53394;9790.559424825757;9836.950815245878;9863.21094312439;10005.349652272578;10381.377117372982;12306.692332691755;17731.556711082325;17934.91032544829;18116.184771685043;18450.630987380446;5732.254806875079;9169;15062;15480.5355839325;16030.198490075683;15159;15519.146446945526;15833.287502062205;16041.358345666044;16205.108719020567;15418.152001639568;16110.67778644444;16376.918115409348;16436.67126657436;16717.331306747594;10209.9489502552;10377.792444151226;10411.895881041093;10545.789084218426;10553.788924221626;11202.775944481227;11813;15073.698526029637;15288.235588220767;16200.108994005443 04:07:00 INFO - 2016-01-25 04:07:00,075 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1534.9462768803087;1548.5431797619701;1746.3014794082374;1819.1359104425396;1871.176682259806;7247.782566522999;7369;7387.482876198668;7812;7815.491993020457;7713.112992005907;7745.148033716301;7758.612069396536;7778.144404115543;7816.921830781705;2249.932502024942;2277.635578307471;2284.680144779732;2288.141946769961;2289.3360925331635;2261.819054475638;2288.3135059482174;2292.8051115655107;2294.300238427279;2321.535692861426;2188.9781102188936;2239.9104035838627;2252.1892118837286;2257.887105644719;2258.141906075689;2207.8564893281887;2232.8883555822226;2233.508628101815;2241.5516896620743;2261.6155253606926;2204;2210.80102790748;2223.321886824518;2230.56503981722;2234.8323875709225;7596.08846938371;7603.695852165907;7624.351930085894;7652.426068044919;7656;4560.065186636732;4618.792154353062;4676.392069031038;4677.111348843709;4687.20317546018;2904.6223990881263;3017.788754787166;3032.651245106819;3049.496833022549;3057.678943710923;872.2237208884098;905.8188362327561;915.2403505090758;948.7722946492861;974.5955428497165;10057.597696092147;10123.835758887675;10134.13859821916;10200.081992620626;10214.02966718168;3997.700172487075;4011.3782363733667;4057.0668746188544;4062.939055914164;4084.550699423061;8390.202930721573;8409.705660301983;8420.073791882887;8441.493510389397;8454.957725211334;4509.34614480905;4509.864704058883;4517.774111294422;4533.048059907391;4544.863654090383;4186.539480657125;4200.810963506649;4212.53662097169;4231.322988321854;4231.386448964883;3311.6357200707903;3328.783629064103;3356.81537515439;3358.1940334320075;3367.983160084233;1007.5264625625944;1008.778068824872;1023.9180865530889;1029.6859457865273;1042.4996001919121;1107.0479387726548;1119.9496022679;1166.049669519356;1324.4768316514924;1385.2519639394613;6984.301569843076;6989.580625162506;6992.0910281663055;7010.263922288188;7099.538529995534;1152.562026429968;1159.6231224851788;1160.495184594704;1168.4274705394296;1194.1521519721096;5583.664980101207;5608.327000759935;5629.915551266734;5638.407967163471;5654.6889921054735;8333.250007499355;8529.530875801767;8616.827663446822;8631.050584435707;8642.783930401665;8425.452345597516;8432;8502.78743031429;8513.787155321166;8526.10475900034;7026.191987921455;7041.155061392666;7052.576845389293;7123.465740069516;7310.34206921369;7058.400035996998;7089.61007144612;7091.43268538526;7100.076989991268;7109.182444019004;8064.838703225785;8113.148119447373;8323.126071762377;8332.416730829027;8440.15598440151;8304.626291816761;8320.459170153921;8328.83342333162;8337.458065225741;8349.499030058216;6581.80254592363;6730.125083739083;6737.427318677771;6741.831454213684;6747.898781518183;7164.928350716426;7220.3140701633265;7246.492745507764;7252.020977168015;7257.49197556166;6359.427651511386;6726.3609957054005;6878.38094571471;6966.233714291525;7006.929930700628;6537;6795.898061528982;6902.930970690229;7018.789436316919;7029.578225306498;6494.7077381517;6541.509386796104;6638.103855979381;6638.90041649366;6649.035889795856;6178.876422471435;6192.287886892885;6197.349278325711;6206.503479721701;6216.067589861557;6129.325774164928;6205.441510264098;6208.875822483616;6209.751609935733;6257.624542527463 04:07:00 INFO - 2016-01-25 04:07:00,077 DEBUG : BROWSER_OUTPUT: |4;prototype.html;350.973676974227;358.52853497650585;358.62702789099336;360.017153171841;360.67719391144925;6348.523860710442;6350.269718982318;6387.13773640559;6387.169667943167;6548.214214294279;6323.0199319105495;6373.9362606373925;6382.106505089291;6412.519061070415;6412.7114279857515;4745.810167593309;4757.785899634508;4762.833300834472;4763.833265835697;4764.857054288377;4765.404324459442;4768.427788665348;4776.97611511942;4781.115493633689;4787.6648634595595;4660.580547750702;4756.7859446325;4761.119192949315;4763.4998325175875;4764.952350476503;4737.2420412734145;4744.122337367581;4745;4749.4063242094735;4752.120857641347;4063.5123785145674;4067.125568002864;4070.1859628074503;4070.3690927906223;4080.367543030835;6066.575339726221;6116.785912493086;6121.479674227696;6124.32632410439;6129.693515324216;5444.210589464506;5545.750441230154;5552.833414997556;5556.555475561945;5556.666600003972;6804.387605115514;6809.148856392951;6815.522913396064;6820.6930688119155;6826.829329266759;4500.212462818994;4507.1211113832815;4517.915700231953;4520.163769702583;4525.185466616008;6770.390664840139;6953.130858642669;6957.930420695779;7040.260772618853;7040.929590704079;4639.536046395334;4645.512221216791;4682.9531704683195;4720.197566413718;4720.409948756405;4771.71369717818;4771.856844294677;4777.307290442866;4779.498152693917;4787.952120478751;5530.11518157101;5554.805581804699;5555.138953462219;5584.46947539983;5594.440555944454;6635.701393437307;6805.863882722417;6845.760398386033;6853.931460685429;6893.414059804973;1613.9919300403658;1647.5057482755365;1657.4447560067513;1657.8342165783567;1691.4164613208422;1087.217203613397;1093.956241750337;1096.3038470571244;1100.1308965916996;1108.4734750993214;6499.1876015498065;6519.348065193538;6534.313897040743;6542.280349161589;6558.737650494022;6877.3810357067105;6909.51445439233;6940.271271516418;6941.930580694229;6968.721251149998;6485.156929599217;6495.805125846232;6496.0255961606135;6498.057781621733;6500.967495162494;3855.0747820523434;3885.630865067814;3886.1839013806853;3896.4155376693725;3899.1032062625754;7284.6721897514735;7338.522996005243;7341.412686985029;7373.188949215582;7387.741429049957;7118.572885626879;7313.158986716489;7327.890081648779;7351.852962940711;7385.4460915431555;7373.741919032916;7373.81565460857;7388.852222955511;7393.371563417062;7397.334239918433;7132.215456299699;7134.430425306425;7139.107611548557;7141.357277845019;7191.20896701352;6912.723491060301;6979.197392299748;7048.541844780073;7050.506464547638;7058.470614704021;7297.890531641923;7338.522996005243;7353.301436363537;7357.889631655423;7374.299441553044;4650.9767451162525;4727.290906364073;4740.360051393018;4744.240921452551;4747.548982846624;6893.896591551231;6974.337437943387;7103.964480177566;7130.5365151265005;7151.678174482265;6902.93097069043;6908.585484870924;6909.136357955255;6910.585364878123;6919.135108111486;6900.861982760417;6902.93097069043;6904.551204171914;6906.758263460755;6908.620025898624;6655.467562595078;6700.93299067003;6766.560173588701;6787;6790.32096790317;6910.861782764216;6926.134233220848;6938;6948.791536253921;6948.895766563607;6643.103181070687;6706.463482921257;6735.326467353421;6744.932550674431;6759.425448836904 04:07:00 INFO - 2016-01-25 04:07:00,078 DEBUG : BROWSER_OUTPUT: |5;yui.html;778.0702061037059;791.030987040875;807.3178164451041;832.1428928203949;851.8424091543069;14438.711225775478;14535.563933081998;14607.34266957988;14646.26768661568;14698.265086745674;13553.593392198225;14004.369803358848;14051.718965620681;14069.507567235149;14100.435982560686;904.0642934562729;914.1589737441536;933.3746389918737;938.4322484896642;940.6378544260475;869.3393021303823;898.0839543665458;913.6665117232229;913.7989642278689;916.2715641065369;957.7797106665471;959.6976952260015;961.8364877970727;964.6430820596389;967.7000129959699;945.5508633399115;948.369334392628;948.8766460360143;950.7528042708876;951.6669165791986;699.5452955578914;704.2007321689867;704.4047779626259;704.9259827718067;706.3854446631412;13876.58370248894;13920.09519381247;14034.087784293988;14107.153570785684;14130.717385652331;12621.242725436503;12734.80897786534;12786.74426511474;12882;13366.33168341579;10807;10826.133909287239;10889.83665245022;10956.178286628456;11039.172062095375;3799.9430008549894;3805.676517496016;3812.3137835189655;3861.7876016819346;3925.7840818754958;48163;48302.7584862077;48538.51461485375;48758.51241487611;48823.26765098526;10434.530446129942;10445;10527.105196058268;10554.155667546578;10660.62687805923;18649.813501864806;18733.437996859844;18874.905625471783;18922.148503317385;18923.43229703111;8142.389320800964;8163.7142700005215;8236.423450358418;8300.377471689648;8336.041355244104;4561.498235194126;4647.279671650899;4666.463356714022;4792.976035119872;4877.439094504107;2943.5731818886143;2977.7320041196394;2984.925376865596;2988.7907846450976;3005.2637103909683;559.1333433178638;577.3187638586425;578.9305283366023;586.2847326261954;593.9020061689773;572.6964708704394;583.2446981159409;600.7026521871702;676.4216594811463;699.6431819771952;8620.396572239883;8867.911320886838;8887.955560222157;8998.730038098867;9047.909520904706;584.2492397269489;725.539282555581;735.4190189750144;747.428217413679;748.0574476160077;3856.06290894052;3962.1481381503113;4160.54234034256;4188.869005368533;4234.407182994383;59231.111533327035;60750;61276;61766;62155.68922155451;52861.47138528642;53142.20286695703;53189.468105319225;53217;54157.72921135369;48713.75643121762;48946.02107957821;49333.26000110001;49374;49799;8959.507227102311;9030.277577793891;9095.408798428081;9261.629534818532;9320.580573874327;35336.82331588326;35819.82090089533;36775.632243677224;38765.2246955065;39089.80455097706;46082.76958615185;46356.07287854292;46438.76780616075;46443.303350449096;46620;11192.664220073411;11288.43557822122;11873.762524749629;12024.519019239133;12151.149419540547;12695.301758403377;13478;13705.862941370857;13856.099353541988;14295.07082039664;11687.18189726711;11784.175107742376;11943.76112477763;12039.578614748441;12282.938585307016;11620.88379116198;11673.233150866523;11793.646190614296;11906.464209110783;12193.451294691582;11771.411429428666;12264.32546209967;12399.75200496003;12640.810387844005;12980.480780768663;11146.609868654883;11286.943565282121;11453.59912403062;11463.082953363544;11517.712057198638;9694.6122155113;9973.45146016947;10013;10120.746981325527;10121.139703125316 04:07:00 INFO - 2016-01-25 04:07:00,078 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:00 INFO - 2016-01-25 04:07:00,078 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:07:00 INFO - 2016-01-25 04:07:00,078 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,305 04:07:00 INFO - 2016-01-25 04:07:00,078 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:07:00 INFO - 2016-01-25 04:07:00,079 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723620070__endTimestamp 04:07:00 INFO - 2016-01-25 04:07:00,079 DEBUG : BROWSER_OUTPUT: 04:07:00 INFO - 2016-01-25 04:07:00,079 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:00 INFO - 2016-01-25 04:07:00,079 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:07:00 INFO - 2016-01-25 04:07:00,079 DEBUG : BROWSER_OUTPUT: 04:07:00 INFO - 2016-01-25 04:07:00,079 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5639.84 Median:5862.53 stddev:646.30 (11.0%) stddev-sans-first:623.00 04:07:00 INFO - 2016-01-25 04:07:00,079 DEBUG : BROWSER_OUTPUT: Values: 3358.0 3381.3 3382.3 3394.6 3414.8 5574.7 5609.8 5610.7 5611.9 5615.3 5557.2 5603.6 5604.5 5609.4 5647.5 5075.8 5089.9 5134.5 5181.5 5184.0 5026.8 5046.6 5115.1 5116.9 5131.1 5050.8 5124.2 5129.3 5142.5 5181.2 5119.3 5119.5 5126.8 5143.9 5156.8 4824.9 4907.1 4994.0 5088.7 5106.3 5469.6 5505.5 5513.9 5519.4 5572.9 6112.6 6137.1 6139.8 6185.2 6193.8 5888.6 6005.6 6016.8 6100.2 6196.1 5745.4 5747.4 5768.2 5775.9 5777.5 6212.7 6218.1 6243.3 6244.2 6249.7 5777.9 5876.1 5968.4 6014.2 6080.4 6147.6 6149.9 6161.7 6164.3 6171.8 5786.8 6039.8 6052.5 6097.3 6104.3 5812.2 5942.7 6086.8 6126.3 6191.7 4657.5 4659.7 4669.8 4685.6 4693.2 4100.2 4166.5 4173.9 4178.3 4189.4 5753.2 5774.1 5778.5 5808.6 5868.3 6082.4 6143.8 6166.6 6173.4 6190.0 5585.2 5714.0 5788.3 5862.5 5871.6 5150.4 5179.7 5200.7 5210.6 5255.4 6212.9 6270.3 6272.3 6320.7 6342.8 6150.6 6171.8 6182.8 6184.5 6187.1 5988.6 6027.4 6214.4 6302.8 6388.7 6050.0 6052.7 6080.6 6089.1 6131.4 6157.4 6173.4 6185.5 6188.8 6209.7 5678.8 5852.8 5916.4 5997.6 6037.6 5971.8 6005.7 6010.2 6012.1 6044.3 5669.9 5871.5 5877.9 5880.4 5899.8 5897.6 5929.6 6010.6 6034.8 6035.8 5761.7 5789.4 5816.9 5840.1 5877.7 04:07:00 INFO - 2016-01-25 04:07:00,079 DEBUG : BROWSER_OUTPUT: 04:07:00 INFO - 2016-01-25 04:07:00,080 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:56037.42 Median:39296.51 stddev:115713.48 (294.5%) stddev-sans-first:115963.29 04:07:00 INFO - 2016-01-25 04:07:00,080 DEBUG : BROWSER_OUTPUT: Values: 621.3 621.8 622.3 626.6 674.6 40224.4 40904.4 40913.8 41075.8 41126.2 42349.8 43081.8 43084.6 43128.8 43175.8 8863.4 9016.0 9066.6 9068.2 9090.3 8826.9 8893.7 8921.2 8958.3 8962.6 8829.0 8946.6 8973.3 8977.7 8986.3 8929.8 8994.7 9026.0 9043.9 9047.5 8659.6 8838.0 8844.1 8857.2 8859.5 38667.2 39016.4 39293.2 39299.8 39330.0 3614.9 3662.2 3711.5 3723.9 3767.2 31938.8 32264.8 32284.7 32421.4 32605.0 3691.1 3708.8 3724.2 3773.8 3796.8 285866.0 285974.0 286115.6 286320.0 288566.0 44503.3 45389.8 45470.3 60588.0 61367.0 43786.6 43891.0 43964.8 43988.8 44015.0 15014.9 15221.6 15252.9 15277.6 15299.3 11906.8 12016.6 12068.7 12112.4 12136.5 15408.2 15428.3 15490.8 15501.1 15539.9 6101.5 6253.3 6356.6 6390.2 6391.5 988.4 996.8 1005.2 1023.9 1065.4 30210.7 30664.0 30902.9 30960.5 31450.5 1141.3 1161.9 1199.2 1217.8 1219.9 16112.6 16135.8 16176.7 16281.3 16363.1 543055.0 544527.0 550373.0 552062.0 835220.0 58067.7 58379.4 58776.7 58886.4 58890.4 1438.4 1443.2 1450.9 1451.8 1462.2 29967.6 30194.7 30958.5 30985.4 31255.4 47690.0 47930.5 48215.3 48461.8 48564.5 314764.0 316530.0 317788.0 318630.0 318671.0 34222.3 34261.3 34497.7 34560.8 34648.8 45035.0 45505.0 45601.8 54619.5 55237.0 39356.4 39373.4 39577.0 39652.8 40451.8 39407.8 39789.2 43018.0 44522.8 45235.5 38441.4 38773.4 38885.4 38918.8 38943.8 32890.8 33714.8 34049.8 34306.1 37704.6 26004.3 27154.9 29822.6 30567.2 30632.5 04:07:00 INFO - 2016-01-25 04:07:00,080 DEBUG : BROWSER_OUTPUT: 04:07:00 INFO - 2016-01-25 04:07:00,080 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:31815.91 Median:37533.31 stddev:103647.32 (276.1%) stddev-sans-first:103911.18 04:07:00 INFO - 2016-01-25 04:07:00,080 DEBUG : BROWSER_OUTPUT: Values: 370.0 380.2 380.4 380.6 385.1 15646.8 16998.6 18472.9 19262.5 19307.2 17600.8 17860.4 18053.1 18446.7 18470.8 5440.6 5588.6 5626.1 5627.5 5631.3 5174.8 5305.2 5367.5 5382.4 5541.7 5256.8 5290.0 5290.2 5334.4 5456.7 5519.7 5526.4 5559.4 5561.3 5584.2 5282.0 5371.6 5398.9 5405.1 5445.0 13303.5 13431.8 13462.9 16859.5 22395.6 2173.1 2245.8 2311.1 2337.2 2356.5 9879.9 10034.7 10431.7 11621.8 13266.3 1969.2 2014.9 2025.7 2068.6 2071.1 64247.4 65954.3 66912.0 67493.3 67509.7 10609.4 10927.8 11014.9 11115.7 11160.4 14291.9 14331.9 14338.7 14342.6 14347.0 7602.5 7642.4 7690.8 7732.4 7777.1 7384.9 7676.3 7703.0 7710.3 7721.5 4681.2 4713.0 4728.9 4763.1 4778.0 1954.7 1957.6 1960.2 1961.1 1991.6 440.2 446.0 959.3 1020.2 1104.6 11019.4 11337.9 11439.5 11492.0 11648.5 453.8 454.0 474.6 475.7 482.0 6071.5 6199.6 6199.7 6204.4 6266.7 612769.0 626630.0 633496.0 635957.0 658020.0 86968.6 87191.6 87946.6 88713.0 89360.6 509.9 516.2 516.7 516.8 518.1 10548.7 10629.3 10648.9 10723.3 10734.0 36361.6 37093.3 37121.0 37445.8 37620.8 51764.0 52521.2 52748.2 53332.0 53394.0 9790.6 9837.0 9863.2 10005.3 10381.4 12306.7 17731.6 17934.9 18116.2 18450.6 5732.3 9169.0 15062.0 15480.5 16030.2 15159.0 15519.1 15833.3 16041.4 16205.1 15418.2 16110.7 16376.9 16436.7 16717.3 10209.9 10377.8 10411.9 10545.8 10553.8 11202.8 11813.0 15073.7 15288.2 16200.1 04:07:00 INFO - 2016-01-25 04:07:00,080 DEBUG : BROWSER_OUTPUT: 04:07:00 INFO - 2016-01-25 04:07:00,080 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5266.44 Median:6207.69 stddev:2668.89 (43.0%) stddev-sans-first:2661.64 04:07:00 INFO - 2016-01-25 04:07:00,082 DEBUG : BROWSER_OUTPUT: Values: 1534.9 1548.5 1746.3 1819.1 1871.2 7247.8 7369.0 7387.5 7812.0 7815.5 7713.1 7745.1 7758.6 7778.1 7816.9 2249.9 2277.6 2284.7 2288.1 2289.3 2261.8 2288.3 2292.8 2294.3 2321.5 2189.0 2239.9 2252.2 2257.9 2258.1 2207.9 2232.9 2233.5 2241.6 2261.6 2204.0 2210.8 2223.3 2230.6 2234.8 7596.1 7603.7 7624.4 7652.4 7656.0 4560.1 4618.8 4676.4 4677.1 4687.2 2904.6 3017.8 3032.7 3049.5 3057.7 872.2 905.8 915.2 948.8 974.6 10057.6 10123.8 10134.1 10200.1 10214.0 3997.7 4011.4 4057.1 4062.9 4084.6 8390.2 8409.7 8420.1 8441.5 8455.0 4509.3 4509.9 4517.8 4533.0 4544.9 4186.5 4200.8 4212.5 4231.3 4231.4 3311.6 3328.8 3356.8 3358.2 3368.0 1007.5 1008.8 1023.9 1029.7 1042.5 1107.0 1119.9 1166.0 1324.5 1385.3 6984.3 6989.6 6992.1 7010.3 7099.5 1152.6 1159.6 1160.5 1168.4 1194.2 5583.7 5608.3 5629.9 5638.4 5654.7 8333.3 8529.5 8616.8 8631.1 8642.8 8425.5 8432.0 8502.8 8513.8 8526.1 7026.2 7041.2 7052.6 7123.5 7310.3 7058.4 7089.6 7091.4 7100.1 7109.2 8064.8 8113.1 8323.1 8332.4 8440.2 8304.6 8320.5 8328.8 8337.5 8349.5 6581.8 6730.1 6737.4 6741.8 6747.9 7164.9 7220.3 7246.5 7252.0 7257.5 6359.4 6726.4 6878.4 6966.2 7006.9 6537.0 6795.9 6902.9 7018.8 7029.6 6494.7 6541.5 6638.1 6638.9 6649.0 6178.9 6192.3 6197.3 6206.5 6216.1 6129.3 6205.4 6208.9 6209.8 6257.6 04:07:00 INFO - 2016-01-25 04:07:00,082 DEBUG : BROWSER_OUTPUT: 04:07:00 INFO - 2016-01-25 04:07:00,082 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5669.20 Median:6495.92 stddev:1760.41 (27.1%) stddev-sans-first:1719.49 04:07:00 INFO - 2016-01-25 04:07:00,082 DEBUG : BROWSER_OUTPUT: Values: 351.0 358.5 358.6 360.0 360.7 6348.5 6350.3 6387.1 6387.2 6548.2 6323.0 6373.9 6382.1 6412.5 6412.7 4745.8 4757.8 4762.8 4763.8 4764.9 4765.4 4768.4 4777.0 4781.1 4787.7 4660.6 4756.8 4761.1 4763.5 4765.0 4737.2 4744.1 4745.0 4749.4 4752.1 4063.5 4067.1 4070.2 4070.4 4080.4 6066.6 6116.8 6121.5 6124.3 6129.7 5444.2 5545.8 5552.8 5556.6 5556.7 6804.4 6809.1 6815.5 6820.7 6826.8 4500.2 4507.1 4517.9 4520.2 4525.2 6770.4 6953.1 6957.9 7040.3 7040.9 4639.5 4645.5 4683.0 4720.2 4720.4 4771.7 4771.9 4777.3 4779.5 4788.0 5530.1 5554.8 5555.1 5584.5 5594.4 6635.7 6805.9 6845.8 6853.9 6893.4 1614.0 1647.5 1657.4 1657.8 1691.4 1087.2 1094.0 1096.3 1100.1 1108.5 6499.2 6519.3 6534.3 6542.3 6558.7 6877.4 6909.5 6940.3 6941.9 6968.7 6485.2 6495.8 6496.0 6498.1 6501.0 3855.1 3885.6 3886.2 3896.4 3899.1 7284.7 7338.5 7341.4 7373.2 7387.7 7118.6 7313.2 7327.9 7351.9 7385.4 7373.7 7373.8 7388.9 7393.4 7397.3 7132.2 7134.4 7139.1 7141.4 7191.2 6912.7 6979.2 7048.5 7050.5 7058.5 7297.9 7338.5 7353.3 7357.9 7374.3 4651.0 4727.3 4740.4 4744.2 4747.5 6893.9 6974.3 7104.0 7130.5 7151.7 6902.9 6908.6 6909.1 6910.6 6919.1 6900.9 6902.9 6904.6 6906.8 6908.6 6655.5 6700.9 6766.6 6787.0 6790.3 6910.9 6926.1 6938.0 6948.8 6948.9 6643.1 6706.5 6735.3 6744.9 6759.4 04:07:00 INFO - 2016-01-25 04:07:00,082 DEBUG : BROWSER_OUTPUT: 04:07:00 INFO - 2016-01-25 04:07:00,082 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:14534.11 Median:46397.42 stddev:16644.84 (35.9%) stddev-sans-first:16659.47 04:07:00 INFO - 2016-01-25 04:07:00,083 DEBUG : BROWSER_OUTPUT: Values: 778.1 791.0 807.3 832.1 851.8 14438.7 14535.6 14607.3 14646.3 14698.3 13553.6 14004.4 14051.7 14069.5 14100.4 904.1 914.2 933.4 938.4 940.6 869.3 898.1 913.7 913.8 916.3 957.8 959.7 961.8 964.6 967.7 945.6 948.4 948.9 950.8 951.7 699.5 704.2 704.4 704.9 706.4 13876.6 13920.1 14034.1 14107.2 14130.7 12621.2 12734.8 12786.7 12882.0 13366.3 10807.0 10826.1 10889.8 10956.2 11039.2 3799.9 3805.7 3812.3 3861.8 3925.8 48163.0 48302.8 48538.5 48758.5 48823.3 10434.5 10445.0 10527.1 10554.2 10660.6 18649.8 18733.4 18874.9 18922.1 18923.4 8142.4 8163.7 8236.4 8300.4 8336.0 4561.5 4647.3 4666.5 4793.0 4877.4 2943.6 2977.7 2984.9 2988.8 3005.3 559.1 577.3 578.9 586.3 593.9 572.7 583.2 600.7 676.4 699.6 8620.4 8867.9 8888.0 8998.7 9047.9 584.2 725.5 735.4 747.4 748.1 3856.1 3962.1 4160.5 4188.9 4234.4 59231.1 60750.0 61276.0 61766.0 62155.7 52861.5 53142.2 53189.5 53217.0 54157.7 48713.8 48946.0 49333.3 49374.0 49799.0 8959.5 9030.3 9095.4 9261.6 9320.6 35336.8 35819.8 36775.6 38765.2 39089.8 46082.8 46356.1 46438.8 46443.3 46620.0 11192.7 11288.4 11873.8 12024.5 12151.1 12695.3 13478.0 13705.9 13856.1 14295.1 11687.2 11784.2 11943.8 12039.6 12282.9 11620.9 11673.2 11793.6 11906.5 12193.5 11771.4 12264.3 12399.8 12640.8 12980.5 11146.6 11286.9 11453.6 11463.1 11517.7 9694.6 9973.5 10013.0 10120.7 10121.1 04:07:00 INFO - 2016-01-25 04:07:00,083 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:00 INFO - 2016-01-25 04:07:00,083 DEBUG : BROWSER_OUTPUT: 04:07:00 INFO - 2016-01-25 04:07:00,769 INFO : Browser exited with error code: 0 04:07:00 INFO - 2016-01-25 04:07:00,788 INFO : Completed test dromaeo_css (00:18:29) 04:07:00 INFO - 2016-01-25 04:07:00,788 INFO : Starting test kraken 04:07:00 INFO - 2016-01-25 04:07:00,788 DEBUG : operating with platform_type : linux_ 04:07:00 INFO - 2016-01-25 04:07:00,788 INFO : Initialising browser for kraken test... 04:07:00 INFO - 2016-01-25 04:07:00,795 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppMTQPv/profile http://localhost:48091/getInfo.html 04:07:04 INFO - 2016-01-25 04:07:04,280 DEBUG : BROWSER_OUTPUT: 04:07:04 INFO - 2016-01-25 04:07:04,281 DEBUG : BROWSER_OUTPUT: (process:6551): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:07:05 INFO - 2016-01-25 04:07:05,124 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:07:05 INFO - 2016-01-25 04:07:05,124 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:07:05 INFO - 2016-01-25 04:07:05,124 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:07:05 INFO - 2016-01-25 04:07:05,124 DEBUG : BROWSER_OUTPUT: __metrics 04:07:06 INFO - 2016-01-25 04:07:06,141 INFO : Browser initialized. 04:07:06 INFO - 2016-01-25 04:07:06,142 INFO : Running cycle 1/1 for kraken test... 04:07:06 INFO - 2016-01-25 04:07:06,142 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmppMTQPv/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:07 INFO - 2016-01-25 04:07:07,452 DEBUG : BROWSER_OUTPUT: 04:07:07 INFO - 2016-01-25 04:07:07,453 DEBUG : BROWSER_OUTPUT: (process:6664): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:07:17 INFO - 2016-01-25 04:07:17,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 138362880 04:07:17 INFO - 2016-01-25 04:07:17,958 DEBUG : BROWSER_OUTPUT: 04:07:20 INFO - 2016-01-25 04:07:20,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48091/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:21 INFO - 2016-01-25 04:07:21,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 139390976 04:07:21 INFO - 2016-01-25 04:07:21,038 DEBUG : BROWSER_OUTPUT: 04:07:23 INFO - 2016-01-25 04:07:23,619 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48091/tests/kraken/driver.html?testName=audio-dft) 04:07:24 INFO - 2016-01-25 04:07:24,215 DEBUG : BROWSER_OUTPUT: RSS: Main: 138452992 04:07:24 INFO - 2016-01-25 04:07:24,215 DEBUG : BROWSER_OUTPUT: 04:07:27 INFO - 2016-01-25 04:07:27,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48091/tests/kraken/driver.html?testName=audio-fft) 04:07:27 INFO - 2016-01-25 04:07:27,604 DEBUG : BROWSER_OUTPUT: RSS: Main: 138432512 04:07:27 INFO - 2016-01-25 04:07:27,604 DEBUG : BROWSER_OUTPUT: 04:07:29 INFO - 2016-01-25 04:07:29,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48091/tests/kraken/driver.html?testName=audio-oscillator) 04:07:30 INFO - 2016-01-25 04:07:30,207 DEBUG : BROWSER_OUTPUT: RSS: Main: 139321344 04:07:30 INFO - 2016-01-25 04:07:30,207 DEBUG : BROWSER_OUTPUT: 04:07:32 INFO - 2016-01-25 04:07:32,382 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48091/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:32 INFO - 2016-01-25 04:07:32,964 DEBUG : BROWSER_OUTPUT: RSS: Main: 138256384 04:07:32 INFO - 2016-01-25 04:07:32,964 DEBUG : BROWSER_OUTPUT: 04:07:35 INFO - 2016-01-25 04:07:35,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48091/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:36 INFO - 2016-01-25 04:07:36,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 139239424 04:07:36 INFO - 2016-01-25 04:07:36,471 DEBUG : BROWSER_OUTPUT: 04:07:39 INFO - 2016-01-25 04:07:39,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48091/tests/kraken/driver.html?testName=imaging-desaturate) 04:07:40 INFO - 2016-01-25 04:07:40,419 DEBUG : BROWSER_OUTPUT: RSS: Main: 139284480 04:07:40 INFO - 2016-01-25 04:07:40,420 DEBUG : BROWSER_OUTPUT: 04:07:43 INFO - 2016-01-25 04:07:43,190 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48091/tests/kraken/driver.html?testName=json-parse-financial) 04:07:43 INFO - 2016-01-25 04:07:43,775 DEBUG : BROWSER_OUTPUT: RSS: Main: 137936896 04:07:43 INFO - 2016-01-25 04:07:43,776 DEBUG : BROWSER_OUTPUT: 04:07:45 INFO - 2016-01-25 04:07:45,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48091/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:07:45 INFO - 2016-01-25 04:07:45,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 138031104 04:07:45 INFO - 2016-01-25 04:07:45,934 DEBUG : BROWSER_OUTPUT: 04:07:47 INFO - 2016-01-25 04:07:47,684 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:07:48 INFO - 2016-01-25 04:07:48,290 DEBUG : BROWSER_OUTPUT: RSS: Main: 137826304 04:07:48 INFO - 2016-01-25 04:07:48,290 DEBUG : BROWSER_OUTPUT: 04:07:50 INFO - 2016-01-25 04:07:50,343 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:07:50 INFO - 2016-01-25 04:07:50,945 DEBUG : BROWSER_OUTPUT: RSS: Main: 138895360 04:07:50 INFO - 2016-01-25 04:07:50,945 DEBUG : BROWSER_OUTPUT: 04:07:53 INFO - 2016-01-25 04:07:53,364 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:07:53 INFO - 2016-01-25 04:07:53,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 138199040 04:07:53 INFO - 2016-01-25 04:07:53,958 DEBUG : BROWSER_OUTPUT: 04:07:56 INFO - 2016-01-25 04:07:56,472 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:57 INFO - 2016-01-25 04:07:57,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 138575872 04:07:57 INFO - 2016-01-25 04:07:57,058 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,707 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48091/tests/kraken/driver.html?testName=ai-astar) 04:07:58 INFO - 2016-01-25 04:07:58,952 DEBUG : BROWSER_OUTPUT: RSS: Main: 140214272 04:07:58 INFO - 2016-01-25 04:07:58,952 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,955 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:58 INFO - 2016-01-25 04:07:58,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:58 INFO - 2016-01-25 04:07:58,956 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:58 INFO - 2016-01-25 04:07:58,956 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:58 INFO - 2016-01-25 04:07:58,956 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;109;112;112;112;121;112;112;111;111 04:07:58 INFO - 2016-01-25 04:07:58,956 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;122;151;163;124;145;160;125;163;124 04:07:58 INFO - 2016-01-25 04:07:58,957 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;163;164;162;162;160;161;161;163;161 04:07:58 INFO - 2016-01-25 04:07:58,957 DEBUG : BROWSER_OUTPUT: |3;audio-fft;78;73;74;156;71;72;70;73;151;73 04:07:58 INFO - 2016-01-25 04:07:58,957 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;140;92;93;94;140;93;92;135 04:07:58 INFO - 2016-01-25 04:07:58,957 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;111;111;110;110;110;112;110;110;110;110 04:07:58 INFO - 2016-01-25 04:07:58,957 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;151;147;147;154;147;146;146;146;146;147 04:07:58 INFO - 2016-01-25 04:07:58,957 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;96;96;96;97;96;96;98;97;95 04:07:58 INFO - 2016-01-25 04:07:58,957 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;61;59;59;58;60;61;58;60;59 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;63;64;62;64;64;67;64;64;65;65 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;88;84;83;84;83;91;82;85;86;82 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;116;123;123;113;117;123;122;114;115;120 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;143;154;151;145;145;148;145;144;144 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;67;64;64;67;66;64;63;63;67 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,706 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:07:58 INFO - 2016-01-25 04:07:58,958 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723678953__endTimestamp 04:07:58 INFO - 2016-01-25 04:07:58,959 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,960 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:58 INFO - 2016-01-25 04:07:58,960 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:07:58 INFO - 2016-01-25 04:07:58,960 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,960 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:3.20 (2.9%) stddev-sans-first:3.36 04:07:58 INFO - 2016-01-25 04:07:58,960 DEBUG : BROWSER_OUTPUT: Values: 111.0 109.0 112.0 112.0 112.0 121.0 112.0 112.0 111.0 111.0 04:07:58 INFO - 2016-01-25 04:07:58,960 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,961 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:143.20 Median:153.00 stddev:17.60 (11.5%) stddev-sans-first:18.14 04:07:58 INFO - 2016-01-25 04:07:58,961 DEBUG : BROWSER_OUTPUT: Values: 155.0 122.0 151.0 163.0 124.0 145.0 160.0 125.0 163.0 124.0 04:07:58 INFO - 2016-01-25 04:07:58,961 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,961 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.27 04:07:58 INFO - 2016-01-25 04:07:58,961 DEBUG : BROWSER_OUTPUT: Values: 160.0 163.0 164.0 162.0 162.0 160.0 161.0 161.0 163.0 161.0 04:07:58 INFO - 2016-01-25 04:07:58,961 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,961 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.10 Median:73.00 stddev:34.03 (46.6%) stddev-sans-first:35.85 04:07:58 INFO - 2016-01-25 04:07:58,962 DEBUG : BROWSER_OUTPUT: Values: 78.0 73.0 74.0 156.0 71.0 72.0 70.0 73.0 151.0 73.0 04:07:58 INFO - 2016-01-25 04:07:58,962 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,962 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:93.00 stddev:22.02 (23.7%) stddev-sans-first:22.80 04:07:58 INFO - 2016-01-25 04:07:58,962 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 140.0 92.0 93.0 94.0 140.0 93.0 92.0 135.0 04:07:58 INFO - 2016-01-25 04:07:58,962 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,962 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.71 04:07:58 INFO - 2016-01-25 04:07:58,962 DEBUG : BROWSER_OUTPUT: Values: 111.0 111.0 110.0 110.0 110.0 112.0 110.0 110.0 110.0 110.0 04:07:58 INFO - 2016-01-25 04:07:58,963 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,964 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.70 Median:147.00 stddev:2.67 (1.8%) stddev-sans-first:2.55 04:07:58 INFO - 2016-01-25 04:07:58,964 DEBUG : BROWSER_OUTPUT: Values: 151.0 147.0 147.0 154.0 147.0 146.0 146.0 146.0 146.0 147.0 04:07:58 INFO - 2016-01-25 04:07:58,964 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,964 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 04:07:58 INFO - 2016-01-25 04:07:58,964 DEBUG : BROWSER_OUTPUT: Values: 97.0 96.0 96.0 96.0 97.0 96.0 96.0 98.0 97.0 95.0 04:07:58 INFO - 2016-01-25 04:07:58,964 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,965 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.40 Median:59.50 stddev:1.07 (1.8%) stddev-sans-first:1.13 04:07:58 INFO - 2016-01-25 04:07:58,965 DEBUG : BROWSER_OUTPUT: Values: 59.0 61.0 59.0 59.0 58.0 60.0 61.0 58.0 60.0 59.0 04:07:58 INFO - 2016-01-25 04:07:58,965 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,965 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:1.32 (2.1%) stddev-sans-first:1.32 04:07:58 INFO - 2016-01-25 04:07:58,965 DEBUG : BROWSER_OUTPUT: Values: 63.0 64.0 62.0 64.0 64.0 67.0 64.0 64.0 65.0 65.0 04:07:58 INFO - 2016-01-25 04:07:58,966 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,966 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:84.50 stddev:2.86 (3.4%) stddev-sans-first:2.79 04:07:58 INFO - 2016-01-25 04:07:58,966 DEBUG : BROWSER_OUTPUT: Values: 88.0 84.0 83.0 84.0 83.0 91.0 82.0 85.0 86.0 82.0 04:07:58 INFO - 2016-01-25 04:07:58,966 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,966 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:118.60 Median:121.00 stddev:4.03 (3.3%) stddev-sans-first:4.17 04:07:58 INFO - 2016-01-25 04:07:58,966 DEBUG : BROWSER_OUTPUT: Values: 116.0 123.0 123.0 113.0 117.0 123.0 122.0 114.0 115.0 120.0 04:07:58 INFO - 2016-01-25 04:07:58,967 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,967 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:146.50 stddev:3.53 (2.4%) stddev-sans-first:3.71 04:07:58 INFO - 2016-01-25 04:07:58,967 DEBUG : BROWSER_OUTPUT: Values: 148.0 143.0 154.0 151.0 145.0 145.0 148.0 145.0 144.0 144.0 04:07:58 INFO - 2016-01-25 04:07:58,967 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2016-01-25 04:07:58,967 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:66.50 stddev:1.89 (2.8%) stddev-sans-first:1.73 04:07:58 INFO - 2016-01-25 04:07:58,967 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 64.0 64.0 67.0 66.0 64.0 63.0 63.0 67.0 04:07:58 INFO - 2016-01-25 04:07:58,967 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:58 INFO - 2016-01-25 04:07:58,967 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2016-01-25 04:07:59,769 INFO : Browser exited with error code: 0 04:07:59 INFO - 2016-01-25 04:07:59,823 INFO : Completed test kraken (00:00:59) 04:07:59 INFO - 2016-01-25 04:07:59,823 INFO : Starting test v8_7 04:07:59 INFO - 2016-01-25 04:07:59,823 DEBUG : operating with platform_type : linux_ 04:07:59 INFO - 2016-01-25 04:07:59,823 INFO : Initialising browser for v8_7 test... 04:07:59 INFO - 2016-01-25 04:07:59,829 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnVazyS/profile http://localhost:48091/getInfo.html 04:08:03 INFO - 2016-01-25 04:08:03,411 DEBUG : BROWSER_OUTPUT: 04:08:03 INFO - 2016-01-25 04:08:03,411 DEBUG : BROWSER_OUTPUT: (process:6974): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:08:04 INFO - 2016-01-25 04:08:04,375 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:08:04 INFO - 2016-01-25 04:08:04,376 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:08:04 INFO - 2016-01-25 04:08:04,376 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:08:04 INFO - 2016-01-25 04:08:04,376 DEBUG : BROWSER_OUTPUT: __metrics 04:08:05 INFO - 2016-01-25 04:08:05,385 INFO : Browser initialized. 04:08:05 INFO - 2016-01-25 04:08:05,386 INFO : Running cycle 1/1 for v8_7 test... 04:08:05 INFO - 2016-01-25 04:08:05,386 DEBUG : command line: /builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpnVazyS/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:08:06 INFO - 2016-01-25 04:08:06,719 DEBUG : BROWSER_OUTPUT: 04:08:06 INFO - 2016-01-25 04:08:06,719 DEBUG : BROWSER_OUTPUT: (process:7089): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:08:17 INFO - 2016-01-25 04:08:17,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 138006528 04:08:17 INFO - 2016-01-25 04:08:17,220 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:48091/tests/v8_7/run.html (next: http://localhost:48091/tests/v8_7/run.html) 04:08:38 INFO - 2016-01-25 04:08:38,838 DEBUG : BROWSER_OUTPUT: RSS: Main: 136196096 04:08:38 INFO - 2016-01-25 04:08:38,838 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,838 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:08:38 INFO - 2016-01-25 04:08:38,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:08:38 INFO - 2016-01-25 04:08:38,839 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:08:38 INFO - 2016-01-25 04:08:38,839 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:08:38 INFO - 2016-01-25 04:08:38,839 DEBUG : BROWSER_OUTPUT: |0;Richards;167.25204883759827 04:08:38 INFO - 2016-01-25 04:08:38,839 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;166.63889351774705 04:08:38 INFO - 2016-01-25 04:08:38,840 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.0078962210942 04:08:38 INFO - 2016-01-25 04:08:38,840 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5207.253886010362 04:08:38 INFO - 2016-01-25 04:08:38,840 DEBUG : BROWSER_OUTPUT: |4;RayTrace;934.5794392523364 04:08:38 INFO - 2016-01-25 04:08:38,840 DEBUG : BROWSER_OUTPUT: |5;Earley;551.2679162072767 04:08:38 INFO - 2016-01-25 04:08:38,840 DEBUG : BROWSER_OUTPUT: |6;Boyer;11087.912087912087 04:08:38 INFO - 2016-01-25 04:08:38,840 DEBUG : BROWSER_OUTPUT: |7;RegExp;25974.358974358973 04:08:38 INFO - 2016-01-25 04:08:38,841 DEBUG : BROWSER_OUTPUT: |8;Splay;532.197977647685 04:08:38 INFO - 2016-01-25 04:08:38,841 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4882.926829268293 04:08:38 INFO - 2016-01-25 04:08:38,841 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:08:38 INFO - 2016-01-25 04:08:38,842 DEBUG : BROWSER_OUTPUT: __startTimestamp1453723718837__endTimestamp 04:08:38 INFO - 2016-01-25 04:08:38,842 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,842 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:08:38 INFO - 2016-01-25 04:08:38,842 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:08:38 INFO - 2016-01-25 04:08:38,843 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,843 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.25 Median:167.25 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,843 DEBUG : BROWSER_OUTPUT: Values: 167.3 04:08:38 INFO - 2016-01-25 04:08:38,843 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,844 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:166.64 Median:166.64 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,844 DEBUG : BROWSER_OUTPUT: Values: 166.6 04:08:38 INFO - 2016-01-25 04:08:38,844 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,844 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.01 Median:282.01 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,844 DEBUG : BROWSER_OUTPUT: Values: 282.0 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5207.25 Median:5207.25 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: Values: 5207.3 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:934.58 Median:934.58 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: Values: 934.6 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:551.27 Median:551.27 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: Values: 551.3 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,845 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11087.91 Median:11087.91 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: Values: 11087.9 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25974.36 Median:25974.36 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: Values: 25974.4 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:532.20 Median:532.20 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: Values: 532.2 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4882.93 Median:4882.93 stddev:0.00 (0.0%) 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: Values: 4882.9 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:08:38 INFO - 2016-01-25 04:08:38,847 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2016-01-25 04:08:39,693 INFO : Browser exited with error code: 0 04:08:39 INFO - 2016-01-25 04:08:39,710 INFO : Completed test v8_7 (00:00:39) 04:08:39 INFO - 2016-01-25 04:08:39,909 INFO : Completed test suite (00:20:08) 04:08:39 INFO - 2016-01-25 04:08:39,910 DEBUG : Working with test: dromaeo_css 04:08:39 INFO - 2016-01-25 04:08:39,910 DEBUG : Generating results file: dromaeo_css 04:08:39 INFO - 2016-01-25 04:08:39,911 DEBUG : Working with test: kraken 04:08:39 INFO - 2016-01-25 04:08:39,911 DEBUG : Generating results file: kraken 04:08:39 INFO - 2016-01-25 04:08:39,911 INFO : javascript benchmark 04:08:39 INFO - 2016-01-25 04:08:39,911 DEBUG : Working with test: v8_7 04:08:39 INFO - 2016-01-25 04:08:39,911 DEBUG : Generating results file: v8_7 04:08:39 INFO - 2016-01-25 04:08:39,912 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:39 INFO - 2016-01-25 04:08:39,963 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 04:08:39 INFO - 2016-01-25 04:08:39,963 DEBUG : process_Request line: dromaeo_css 7183.98 graph.html#tests=[[72,52,43]] 04:08:39 INFO - 2016-01-25 04:08:39,963 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:39 INFO - 2016-01-25 04:08:39,993 DEBUG : process_Request line: kraken 1506.30 graph.html#tests=[[232,52,43]] 04:08:39 INFO - 2016-01-25 04:08:39,993 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:40 INFO - 2016-01-25 04:08:40,021 DEBUG : process_Request line: v8_7 22891.73 graph.html#tests=[[230,52,43]] 04:08:40 INFO - 2016-01-25 04:08:40,022 INFO : javascript benchmark 04:08:40 INFO - 2016-01-25 04:08:40,026 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3357.9999999999986, 3381.340638575478, 3382.3066271414364, 3394.6096198937116, 3414.7780394274355, 5574.721263936807, 5609.803656872005, 5610.69141197234, 5611.915821262679, 5615.270014898063, 5557.221988921544, 5603.579731520143, 5604.495595396414, 5609.411011843759, 5647.491725744682, 5075.7715902784275, 5089.872753181163, 5134.512221338967, 5181.533661970422, 5183.974080129594, 5026.849194524152, 5046.596272298226, 5115.130427827278, 5116.923246151292, 5131.1277082895995, 5050.823221187259, 5124.231365295217, 5129.2562578426105, 5142.537171654551, 5181.1710126379785, 5119.334486516729, 5119.46582953385, 5126.820561280375, 5143.922841157367, 5156.793728250866, 4824.903501929977, 4907.141250281186, 4993.975030124826, 5088.720120393377, 5106.336176297094, 5469.644473109235, 5505.532029777473, 5513.862153446155, 5519.420460851593, 5572.916406253909, 6112.633242005494, 6137.079438084278, 6139.754409823602, 6185.226846644169, 6193.752249909998, 5888.5877988540815, 6005.579609427342, 6016.8194954151, 6100.23747031621, 6196.101565273055, 5745.368009518949, 5747.39652336507, 5768.192453056576, 5775.8556036099435, 5777.480026797609, 6212.689365531705, 6218.098375735493, 6243.282022567463, 6244.219472565929, 6249.687515624291, 5777.913331300034, 5876.1479585459865, 5968.37332080134, 6014.188084608521, 6080.361562036011, 6147.631142131487, 6149.877002459926, 6161.6611086389785, 6164.260288765287, 6171.814845554641, 5786.797462088806, 6039.849003774941, 6052.54605904559, 6097.3292937776805, 6104.298005729398, 5812.215350927655, 5942.673152976541, 6086.817395478142, 6126.326104128542, 6191.659458729723, 4657.46439159501, 4659.720416774937, 4669.813207471731, 4685.601723853442, 4693.178693728584, 4100.2414553307735, 4166.479190101238, 4173.8956526087095, 4178.289690752579, 4189.413482112506, 5753.223314852525, 5774.133879918046, 5778.451047150598, 5808.6224395414165, 5868.295804503487, 6082.391760823971, 6143.784967526115, 6166.568340216231, 6173.41352571505, 6190.0405437157315, 5585.162225666101, 5714.0, 5788.3343415506915, 5862.530997520188, 5871.588988770745, 5150.356205474316, 5179.689218646893, 5200.713960732196, 5210.5831533477985, 5255.395629502656, 6212.9068063979075, 6270.2789179244055, 6272.341404152589, 6320.747170113144, 6342.841428964312, 6150.630962142286, 6171.84570385744, 6182.814515564451, 6184.474319682698, 6187.071939209155, 5988.610740301867, 6027.397260273938, 6214.40963108504, 6302.779402720883, 6388.712507937061, 6050.0, 6052.727627256696, 6080.568531161388, 6089.117078023751, 6131.386861314011, 6157.415045570664, 6173.38003502632, 6185.474234689922, 6188.783392581238, 6209.720562574786, 5678.801241956512, 5852.795152169653, 5916.437938395846, 5997.5501837363245, 6037.577369584263, 5971.7611295547695, 6005.7297421617, 6010.218671572842, 6012.098185272244, 6044.335123136363, 5669.886602268014, 5871.530277577869, 5877.882442351043, 5880.411958804086, 5899.823005309848, 5897.616654917417, 5929.555283353852, 6010.609310394811, 6034.788782392595, 6035.818925432244, 5761.740721667619, 5789.421057894177, 5816.883662326645, 5840.065589505659, 5877.706114694333], "unit": "ms", "name": "dojo.html", "value": 5596.9570167682}, {"lowerIsBetter": false, "replicates": [621.2731104607609, 621.7937201828454, 622.3496446213703, 626.5958456795368, 674.585130144961, 40224.39663405048, 40904.386434203436, 40913.79543102284, 41075.79462102693, 41126.17747645045, 42349.7882510587, 43081.784591077, 43084.56915430845, 43128.78435607818, 43175.78412107935, 8863.423877447978, 9015.95492022539, 9066.592003359865, 9068.229200517932, 9090.272778177763, 8826.911730882674, 8893.73318800437, 8921.197092261695, 8958.32812539059, 8962.596683149273, 8828.955855220715, 8946.64213431462, 8973.327000474957, 8977.685780997666, 8986.281097512216, 8929.821403571925, 8994.730158095268, 9026.0, 9043.909560904372, 9047.457152570867, 8659.567021648956, 8838.0, 8844.071372505923, 8857.20285174331, 8859.468431894042, 38667.22665546701, 39016.414753778714, 39293.21413571713, 39299.8035009826, 39330.0, 3614.945775813365, 3662.176010397666, 3711.536057992751, 3723.94414083789, 3767.2088861339153, 31938.840305798556, 32264.838675806706, 32284.6771532284, 32421.351572968644, 32605.0, 3691.077230692327, 3708.8145592720257, 3724.16206353571, 3773.792441415721, 3796.791176485292, 285866.0, 285974.0, 286115.56942215364, 286320.0, 288566.0, 44503.33245001327, 45389.77305113519, 45470.31794523085, 60588.0, 61367.0, 43786.56213437889, 43891.0, 43964.78017609892, 43988.78005609952, 44015.0, 15014.924925375302, 15221.6194595136, 15252.923735381251, 15277.6180595486, 15299.311530980909, 11906.821397678868, 12016.579419720269, 12068.698282542831, 12112.39438028095, 12136.45385957634, 15408.229588520753, 15428.305726242346, 15490.767638485431, 15501.147436890853, 15539.922300388653, 6101.542384321105, 6253.343398943045, 6356.555041147075, 6390.233172019387, 6391.488680905516, 988.4020167798523, 996.8255555277798, 1005.1857995024054, 1023.8515415264745, 1065.408698172506, 30210.697893021228, 30664.0, 30902.86943831542, 30960.535591966138, 31450.528242076387, 1141.3323205924628, 1161.895429411357, 1199.2264989081993, 1217.7625363054296, 1219.9024078073733, 16112.597185070466, 16135.83864161367, 16176.676466470604, 16281.348746050262, 16363.100029498491, 543055.0, 544527.0, 550373.0, 552062.0, 835220.0, 58067.70966145227, 58379.4162058374, 58776.70611647, 58886.41113588895, 58890.41109588935, 1438.3743071763815, 1443.1846007006009, 1450.9419623214953, 1451.7677171652697, 1462.1884853906183, 29967.605830949768, 30194.69805301919, 30958.53562196524, 30985.380292394475, 31255.374892501568, 47690.0, 47930.520694792605, 48215.27677084776, 48461.75769121132, 48564.51435485741, 314764.0, 316530.0, 317788.0, 318630.0, 318671.0, 34222.31555368929, 34261.31477370389, 34497.65502344944, 34560.82719586386, 34648.82675586606, 45035.0, 45505.0, 45601.77199113983, 54619.45380546144, 55237.0, 39356.409653854644, 39373.409398859614, 39577.0, 39652.80173599113, 40451.797741011105, 39407.80296098501, 39789.2042159161, 43018.0, 44522.77738611286, 45235.54764452445, 38441.4233786499, 38773.41839872461, 38885.41671874981, 38918.80540597279, 38943.805280973414, 32890.83554582212, 33714.83142584271, 34049.82975085208, 34306.14234644154, 37704.622953771206, 26004.34989125287, 27154.864225678746, 29822.55266170966, 30567.2358191047, 30632.540511891893], "unit": "ms", "name": "ext.html", "value": 19342.03393511994}, {"lowerIsBetter": false, "replicates": [369.9704023678106, 380.22054787685255, 380.3799806315705, 380.61367711772544, 385.1180795977211, 15646.765298520502, 16998.575035624115, 18472.907635461837, 19262.5184370391, 19307.227710891566, 17600.823991760077, 17860.374886878963, 18053.097345132755, 18446.723299150523, 18470.815291847077, 5440.564754819615, 5588.580856435763, 5626.099824028156, 5627.493525582697, 5631.2960879890015, 5174.818881339153, 5305.230741542474, 5367.516923476886, 5382.381026181981, 5541.6674999499955, 5256.763445644955, 5290.0, 5290.232916227144, 5334.439883812202, 5456.727163641822, 5519.668819870801, 5526.392096869341, 5559.416261292547, 5561.304836895388, 5584.246126772895, 5282.049231138393, 5371.57027437804, 5398.865028374283, 5405.054115529767, 5445.0, 13303.53437629688, 13431.798523022162, 13462.865371346259, 16859.494215173563, 22395.55208895829, 2173.0655817998254, 2245.764194759543, 2311.0871205873755, 2337.207102241602, 2356.4580146566213, 9879.86381566122, 10034.69895903124, 10431.739206519822, 11621.767564648744, 13266.270355130464, 1969.222157247879, 2014.909329080195, 2025.6758918573105, 2068.617305798432, 2071.1301253473425, 64247.3575264246, 65954.3404565953, 66912.0, 67493.32506674969, 67509.66245168792, 10609.363438193734, 10927.836082458769, 11014.889851101547, 11115.666530004113, 11160.441977901073, 14291.92854035744, 14331.928340358232, 14338.713225735635, 14342.569722908329, 14347.0, 7602.46782725204, 7642.426817988673, 7690.769276921701, 7732.4200684948855, 7777.144514103444, 7384.889226661604, 7676.347510461674, 7702.96148519265, 7710.306072453506, 7721.498102623312, 4681.227597446383, 4713.0, 4728.88177795551, 4763.071201115749, 4777.95222047782, 1954.7458830351964, 1957.5791204891016, 1960.1767257751778, 1961.08809403628, 1991.5618563915916, 440.2252036415867, 445.97547134907893, 959.2517836087862, 1020.2399212586522, 1104.5581767293147, 11019.393933333584, 11337.886621133848, 11439.51286332788, 11492.0, 11648.53405863773, 453.8456924645636, 454.01931827252974, 474.58948009971124, 475.67416319821035, 481.9783109760069, 6071.453569178795, 6199.628022318585, 6199.659018754011, 6204.410580994799, 6266.686665666698, 612769.0, 626630.0, 633496.0, 635957.0, 658020.0, 86968.56515717508, 87191.56404217938, 87946.56026719825, 88713.0, 89360.5531972336, 509.8827269727983, 516.246280430568, 516.6770768269831, 516.8036146264395, 518.0959226150392, 10548.736281593021, 10629.342664333917, 10648.89351106479, 10723.30298530593, 10733.98027187416, 36361.63638363582, 37093.25813483769, 37121.0, 37445.81277093597, 37620.811895940344, 51764.0, 52521.21218181807, 52748.20877686914, 53332.0, 53394.0, 9790.559424825757, 9836.950815245878, 9863.21094312439, 10005.349652272578, 10381.377117372982, 12306.692332691755, 17731.556711082325, 17934.91032544829, 18116.184771685043, 18450.630987380446, 5732.254806875079, 9169.0, 15062.0, 15480.5355839325, 16030.198490075683, 15159.0, 15519.146446945526, 15833.287502062205, 16041.358345666044, 16205.108719020567, 15418.152001639568, 16110.67778644444, 16376.918115409348, 16436.67126657436, 16717.331306747594, 10209.9489502552, 10377.792444151226, 10411.895881041093, 10545.789084218426, 10553.788924221626, 11202.775944481227, 11813.0, 15073.698526029637, 15288.235588220767, 16200.108994005443], "unit": "ms", "name": "jquery.html", "value": 8532.543414975611}, {"lowerIsBetter": false, "replicates": [1534.9462768803087, 1548.5431797619701, 1746.3014794082374, 1819.1359104425396, 1871.176682259806, 7247.782566522999, 7369.0, 7387.482876198668, 7812.0, 7815.491993020457, 7713.112992005907, 7745.148033716301, 7758.612069396536, 7778.144404115543, 7816.921830781705, 2249.932502024942, 2277.635578307471, 2284.680144779732, 2288.141946769961, 2289.3360925331635, 2261.819054475638, 2288.3135059482174, 2292.8051115655107, 2294.300238427279, 2321.535692861426, 2188.9781102188936, 2239.9104035838627, 2252.1892118837286, 2257.887105644719, 2258.141906075689, 2207.8564893281887, 2232.8883555822226, 2233.508628101815, 2241.5516896620743, 2261.6155253606926, 2204.0, 2210.80102790748, 2223.321886824518, 2230.56503981722, 2234.8323875709225, 7596.08846938371, 7603.695852165907, 7624.351930085894, 7652.426068044919, 7656.0, 4560.065186636732, 4618.792154353062, 4676.392069031038, 4677.111348843709, 4687.20317546018, 2904.6223990881263, 3017.788754787166, 3032.651245106819, 3049.496833022549, 3057.678943710923, 872.2237208884098, 905.8188362327561, 915.2403505090758, 948.7722946492861, 974.5955428497165, 10057.597696092147, 10123.835758887675, 10134.13859821916, 10200.081992620626, 10214.02966718168, 3997.700172487075, 4011.3782363733667, 4057.0668746188544, 4062.939055914164, 4084.550699423061, 8390.202930721573, 8409.705660301983, 8420.073791882887, 8441.493510389397, 8454.957725211334, 4509.34614480905, 4509.864704058883, 4517.774111294422, 4533.048059907391, 4544.863654090383, 4186.539480657125, 4200.810963506649, 4212.53662097169, 4231.322988321854, 4231.386448964883, 3311.6357200707903, 3328.783629064103, 3356.81537515439, 3358.1940334320075, 3367.983160084233, 1007.5264625625944, 1008.778068824872, 1023.9180865530889, 1029.6859457865273, 1042.4996001919121, 1107.0479387726548, 1119.9496022679, 1166.049669519356, 1324.4768316514924, 1385.2519639394613, 6984.301569843076, 6989.580625162506, 6992.0910281663055, 7010.263922288188, 7099.538529995534, 1152.562026429968, 1159.6231224851788, 1160.495184594704, 1168.4274705394296, 1194.1521519721096, 5583.664980101207, 5608.327000759935, 5629.915551266734, 5638.407967163471, 5654.6889921054735, 8333.250007499355, 8529.530875801767, 8616.827663446822, 8631.050584435707, 8642.783930401665, 8425.452345597516, 8432.0, 8502.78743031429, 8513.787155321166, 8526.10475900034, 7026.191987921455, 7041.155061392666, 7052.576845389293, 7123.465740069516, 7310.34206921369, 7058.400035996998, 7089.61007144612, 7091.43268538526, 7100.076989991268, 7109.182444019004, 8064.838703225785, 8113.148119447373, 8323.126071762377, 8332.416730829027, 8440.15598440151, 8304.626291816761, 8320.459170153921, 8328.83342333162, 8337.458065225741, 8349.499030058216, 6581.80254592363, 6730.125083739083, 6737.427318677771, 6741.831454213684, 6747.898781518183, 7164.928350716426, 7220.3140701633265, 7246.492745507764, 7252.020977168015, 7257.49197556166, 6359.427651511386, 6726.3609957054005, 6878.38094571471, 6966.233714291525, 7006.929930700628, 6537.0, 6795.898061528982, 6902.930970690229, 7018.789436316919, 7029.578225306498, 6494.7077381517, 6541.509386796104, 6638.103855979381, 6638.90041649366, 6649.035889795856, 6178.876422471435, 6192.287886892885, 6197.349278325711, 6206.503479721701, 6216.067589861557, 6129.325774164928, 6205.441510264098, 6208.875822483616, 6209.751609935733, 6257.624542527463], "unit": "ms", "name": "mootools.html", "value": 4358.448984815139}, {"lowerIsBetter": false, "replicates": [350.973676974227, 358.52853497650585, 358.62702789099336, 360.017153171841, 360.67719391144925, 6348.523860710442, 6350.269718982318, 6387.13773640559, 6387.169667943167, 6548.214214294279, 6323.0199319105495, 6373.9362606373925, 6382.106505089291, 6412.519061070415, 6412.7114279857515, 4745.810167593309, 4757.785899634508, 4762.833300834472, 4763.833265835697, 4764.857054288377, 4765.404324459442, 4768.427788665348, 4776.97611511942, 4781.115493633689, 4787.6648634595595, 4660.580547750702, 4756.7859446325, 4761.119192949315, 4763.4998325175875, 4764.952350476503, 4737.2420412734145, 4744.122337367581, 4745.0, 4749.4063242094735, 4752.120857641347, 4063.5123785145674, 4067.125568002864, 4070.1859628074503, 4070.3690927906223, 4080.367543030835, 6066.575339726221, 6116.785912493086, 6121.479674227696, 6124.32632410439, 6129.693515324216, 5444.210589464506, 5545.750441230154, 5552.833414997556, 5556.555475561945, 5556.666600003972, 6804.387605115514, 6809.148856392951, 6815.522913396064, 6820.6930688119155, 6826.829329266759, 4500.212462818994, 4507.1211113832815, 4517.915700231953, 4520.163769702583, 4525.185466616008, 6770.390664840139, 6953.130858642669, 6957.930420695779, 7040.260772618853, 7040.929590704079, 4639.536046395334, 4645.512221216791, 4682.9531704683195, 4720.197566413718, 4720.409948756405, 4771.71369717818, 4771.856844294677, 4777.307290442866, 4779.498152693917, 4787.952120478751, 5530.11518157101, 5554.805581804699, 5555.138953462219, 5584.46947539983, 5594.440555944454, 6635.701393437307, 6805.863882722417, 6845.760398386033, 6853.931460685429, 6893.414059804973, 1613.9919300403658, 1647.5057482755365, 1657.4447560067513, 1657.8342165783567, 1691.4164613208422, 1087.217203613397, 1093.956241750337, 1096.3038470571244, 1100.1308965916996, 1108.4734750993214, 6499.1876015498065, 6519.348065193538, 6534.313897040743, 6542.280349161589, 6558.737650494022, 6877.3810357067105, 6909.51445439233, 6940.271271516418, 6941.930580694229, 6968.721251149998, 6485.156929599217, 6495.805125846232, 6496.0255961606135, 6498.057781621733, 6500.967495162494, 3855.0747820523434, 3885.630865067814, 3886.1839013806853, 3896.4155376693725, 3899.1032062625754, 7284.6721897514735, 7338.522996005243, 7341.412686985029, 7373.188949215582, 7387.741429049957, 7118.572885626879, 7313.158986716489, 7327.890081648779, 7351.852962940711, 7385.4460915431555, 7373.741919032916, 7373.81565460857, 7388.852222955511, 7393.371563417062, 7397.334239918433, 7132.215456299699, 7134.430425306425, 7139.107611548557, 7141.357277845019, 7191.20896701352, 6912.723491060301, 6979.197392299748, 7048.541844780073, 7050.506464547638, 7058.470614704021, 7297.890531641923, 7338.522996005243, 7353.301436363537, 7357.889631655423, 7374.299441553044, 4650.9767451162525, 4727.290906364073, 4740.360051393018, 4744.240921452551, 4747.548982846624, 6893.896591551231, 6974.337437943387, 7103.964480177566, 7130.5365151265005, 7151.678174482265, 6902.93097069043, 6908.585484870924, 6909.136357955255, 6910.585364878123, 6919.135108111486, 6900.861982760417, 6902.93097069043, 6904.551204171914, 6906.758263460755, 6908.620025898624, 6655.467562595078, 6700.93299067003, 6766.560173588701, 6787.0, 6790.32096790317, 6910.861782764216, 6926.134233220848, 6938.0, 6948.791536253921, 6948.895766563607, 6643.103181070687, 6706.463482921257, 6735.326467353421, 6744.932550674431, 6759.425448836904], "unit": "ms", "name": "prototype.html", "value": 5092.43963650057}, {"lowerIsBetter": false, "replicates": [778.0702061037059, 791.030987040875, 807.3178164451041, 832.1428928203949, 851.8424091543069, 14438.711225775478, 14535.563933081998, 14607.34266957988, 14646.26768661568, 14698.265086745674, 13553.593392198225, 14004.369803358848, 14051.718965620681, 14069.507567235149, 14100.435982560686, 904.0642934562729, 914.1589737441536, 933.3746389918737, 938.4322484896642, 940.6378544260475, 869.3393021303823, 898.0839543665458, 913.6665117232229, 913.7989642278689, 916.2715641065369, 957.7797106665471, 959.6976952260015, 961.8364877970727, 964.6430820596389, 967.7000129959699, 945.5508633399115, 948.369334392628, 948.8766460360143, 950.7528042708876, 951.6669165791986, 699.5452955578914, 704.2007321689867, 704.4047779626259, 704.9259827718067, 706.3854446631412, 13876.58370248894, 13920.09519381247, 14034.087784293988, 14107.153570785684, 14130.717385652331, 12621.242725436503, 12734.80897786534, 12786.74426511474, 12882.0, 13366.33168341579, 10807.0, 10826.133909287239, 10889.83665245022, 10956.178286628456, 11039.172062095375, 3799.9430008549894, 3805.676517496016, 3812.3137835189655, 3861.7876016819346, 3925.7840818754958, 48163.0, 48302.7584862077, 48538.51461485375, 48758.51241487611, 48823.26765098526, 10434.530446129942, 10445.0, 10527.105196058268, 10554.155667546578, 10660.62687805923, 18649.813501864806, 18733.437996859844, 18874.905625471783, 18922.148503317385, 18923.43229703111, 8142.389320800964, 8163.7142700005215, 8236.423450358418, 8300.377471689648, 8336.041355244104, 4561.498235194126, 4647.279671650899, 4666.463356714022, 4792.976035119872, 4877.439094504107, 2943.5731818886143, 2977.7320041196394, 2984.925376865596, 2988.7907846450976, 3005.2637103909683, 559.1333433178638, 577.3187638586425, 578.9305283366023, 586.2847326261954, 593.9020061689773, 572.6964708704394, 583.2446981159409, 600.7026521871702, 676.4216594811463, 699.6431819771952, 8620.396572239883, 8867.911320886838, 8887.955560222157, 8998.730038098867, 9047.909520904706, 584.2492397269489, 725.539282555581, 735.4190189750144, 747.428217413679, 748.0574476160077, 3856.06290894052, 3962.1481381503113, 4160.54234034256, 4188.869005368533, 4234.407182994383, 59231.111533327035, 60750.0, 61276.0, 61766.0, 62155.68922155451, 52861.47138528642, 53142.20286695703, 53189.468105319225, 53217.0, 54157.72921135369, 48713.75643121762, 48946.02107957821, 49333.26000110001, 49374.0, 49799.0, 8959.507227102311, 9030.277577793891, 9095.408798428081, 9261.629534818532, 9320.580573874327, 35336.82331588326, 35819.82090089533, 36775.632243677224, 38765.2246955065, 39089.80455097706, 46082.76958615185, 46356.07287854292, 46438.76780616075, 46443.303350449096, 46620.0, 11192.664220073411, 11288.43557822122, 11873.762524749629, 12024.519019239133, 12151.149419540547, 12695.301758403377, 13478.0, 13705.862941370857, 13856.099353541988, 14295.07082039664, 11687.18189726711, 11784.175107742376, 11943.76112477763, 12039.578614748441, 12282.938585307016, 11620.88379116198, 11673.233150866523, 11793.646190614296, 11906.464209110783, 12193.451294691582, 11771.411429428666, 12264.32546209967, 12399.75200496003, 12640.810387844005, 12980.480780768663, 11146.609868654883, 11286.943565282121, 11453.59912403062, 11463.082953363544, 11517.712057198638, 9694.6122155113, 9973.45146016947, 10013.0, 10120.746981325527, 10121.139703125316], "unit": "ms", "name": "yui.html", "value": 6704.40515628129}], "name": "dromaeo_css", "value": 7183.974379365689}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 112.0, 112.0, 112.0, 121.0, 112.0, 112.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [155.0, 122.0, 151.0, 163.0, 124.0, 145.0, 160.0, 125.0, 163.0, 124.0], "unit": "ms", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [160.0, 163.0, 164.0, 162.0, 162.0, 160.0, 161.0, 161.0, 163.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.7}, {"lowerIsBetter": true, "replicates": [78.0, 73.0, 74.0, 156.0, 71.0, 72.0, 70.0, 73.0, 151.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 89.1}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 140.0, 92.0, 93.0, 94.0, 140.0, 93.0, 92.0, 135.0], "unit": "ms", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [111.0, 111.0, 110.0, 110.0, 110.0, 112.0, 110.0, 110.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [151.0, 147.0, 147.0, 154.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.7}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 98.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.4}, {"lowerIsBetter": true, "replicates": [59.0, 61.0, 59.0, 59.0, 58.0, 60.0, 61.0, 58.0, 60.0, 59.0], "unit": "ms", "name": "json-parse-financial", "value": 59.4}, {"lowerIsBetter": true, "replicates": [63.0, 64.0, 62.0, 64.0, 64.0, 67.0, 64.0, 64.0, 65.0, 65.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 83.0, 84.0, 83.0, 91.0, 82.0, 85.0, 86.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.8}, {"lowerIsBetter": true, "replicates": [116.0, 123.0, 123.0, 113.0, 117.0, 123.0, 122.0, 114.0, 115.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 118.6}, {"lowerIsBetter": true, "replicates": [148.0, 143.0, 154.0, 151.0, 145.0, 145.0, 148.0, 145.0, 144.0, 144.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 64.0, 64.0, 67.0, 66.0, 64.0, 63.0, 63.0, 67.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 65.3}], "name": "kraken", "value": 1506.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.25204883759827], "unit": "score", "name": "Richards", "value": 211.07065799999992}, {"lowerIsBetter": false, "replicates": [166.63889351774705], "unit": "score", "name": "DeltaBlue", "value": 396.77411799999993}, {"lowerIsBetter": false, "replicates": [282.0078962210942], "unit": "score", "name": "Encrypt", "value": 943.8778259999998}, {"lowerIsBetter": false, "replicates": [5207.253886010362], "unit": "score", "name": "Decrypt", "value": 51.11734626865668}, {"lowerIsBetter": false, "replicates": [934.5794392523364], "unit": "score", "name": "RayTrace", "value": 791.7882300000002}, {"lowerIsBetter": false, "replicates": [551.2679162072767], "unit": "score", "name": "Earley", "value": 1208.9638819999998}, {"lowerIsBetter": false, "replicates": [11087.912087912087], "unit": "score", "name": "Boyer", "value": 60.107168483647186}, {"lowerIsBetter": false, "replicates": [25974.358974358973], "unit": "score", "name": "RegExp", "value": 35.072472852912156}, {"lowerIsBetter": false, "replicates": [532.197977647685], "unit": "score", "name": "Splay", "value": 153.12158900000006}, {"lowerIsBetter": false, "replicates": [4882.926829268293], "unit": "score", "name": "NavierStokes", "value": 303.91608391608383}], "name": "v8_7", "value": 22891.730193557156}]} 04:08:40 INFO - RETURN: dromaeo_css: 7183.98 04:08:40 INFO - RETURN: kraken: 1506.30 04:08:40 INFO - RETURN: v8_7: 22891.73 04:08:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22891.73"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1506.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7183.98"}}} 04:08:40 INFO - Return code: 0 04:08:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:08:40 INFO - # TBPL SUCCESS # 04:08:40 INFO - Running post-action listener: _resource_record_post_action 04:08:40 INFO - Running post-run listener: _resource_record_post_run 04:08:41 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511598592; Read time: 16; Write time: 549448 04:08:41 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 248336384; Read time: 0; Write time: 323600 04:08:41 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 4096; Write bytes: 262664192; Read time: 16; Write time: 225848 04:08:41 INFO - Running post-run listener: _upload_blobber_files 04:08:41 INFO - Blob upload gear active. 04:08:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:08:41 INFO - Copying logs to upload dir... 04:08:41 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs program finished with exit code 0 elapsedTime=1346.458979 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 26 secs) (at 2016-01-25 04:08:41.173304) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:41.176599) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468 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.010002 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 04:08:41.227316) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:41.227613) ========= 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=5bd038846534b2fdfa68eeae000001e2-1453720758.923415-1590469468 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-25 04:08:41.276978) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:08:41.277300) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-25 04:08:41.277591) ========= ========= Total master_lag: 0.37 =========