builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-014 starttime: 1460462413.59 results: success (0) buildid: 20160412022558 builduid: 5f0fd912833d468c944fbaabbcecdcdd revision: 6e8c76e38e0522e0cde432c8ecccfab501018204 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.593421) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.593932) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.594297) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006355 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.16 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.762731) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.763139) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.798271) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.798593) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004581 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.850655) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.851395) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.852166) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:13.852759) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 05:00:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2016-04-12 05:00:15 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.644531 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:14.510648) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:14.511030) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.013833 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:14.562775) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:14.563250) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6e8c76e38e0522e0cde432c8ecccfab501018204 --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 6e8c76e38e0522e0cde432c8ecccfab501018204 --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=fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 05:00:15,202 truncating revision to first 12 chars 2016-04-12 05:00:15,202 Setting DEBUG logging. 2016-04-12 05:00:15,202 attempt 1/10 2016-04-12 05:00:15,202 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6e8c76e38e05?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 05:00:15,461 unpacking tar archive at: mozilla-aurora-6e8c76e38e05/testing/mozharness/ program finished with exit code 0 elapsedTime=0.549629 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:15.126530) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:15.127032) ========= echo 6e8c76e38e0522e0cde432c8ecccfab501018204 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6e8c76e38e0522e0cde432c8ecccfab501018204'] 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=fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6e8c76e38e0522e0cde432c8ecccfab501018204 program finished with exit code 0 elapsedTime=0.004894 script_repo_revision: '6e8c76e38e0522e0cde432c8ecccfab501018204' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:15.180929) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:15.181727) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 05:00:15.192748) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-12 05:00:15.193075) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:00:15 INFO - MultiFileLogger online at 20160412 05:00:15 in /builds/slave/test-pgo 05:00:15 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:00:15 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:00:15 INFO - {'append_to_log': False, 05:00:15 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:00:15 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:00:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:00:15 INFO - 'branch': 'Mozilla-Aurora', 05:00:15 INFO - 'buildbot_json_path': 'buildprops.json', 05:00:15 INFO - 'config_files': ('talos/linux_config.py',), 05:00:15 INFO - 'default_actions': ('clobber', 05:00:15 INFO - 'read-buildbot-config', 05:00:15 INFO - 'download-and-extract', 05:00:15 INFO - 'populate-webroot', 05:00:15 INFO - 'create-virtualenv', 05:00:15 INFO - 'install', 05:00:15 INFO - 'run-tests'), 05:00:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:00:15 INFO - 'download_minidump_stackwalk': True, 05:00:15 INFO - 'download_symbols': 'ondemand', 05:00:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:00:15 INFO - 'tooltool.py': '/tools/tooltool.py', 05:00:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:00:15 INFO - '/tools/misc-python/virtualenv.py')}, 05:00:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:00:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:00:15 INFO - 'installer_path': 'installer.exe', 05:00:15 INFO - 'log_level': 'info', 05:00:15 INFO - 'log_name': 'talos', 05:00:15 INFO - 'log_to_console': True, 05:00:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:00:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:00:15 INFO - 'opt_config_files': (), 05:00:15 INFO - 'pip_index': False, 05:00:15 INFO - 'sps_profile': False, 05:00:15 INFO - 'sps_profile_interval': 0, 05:00:15 INFO - 'suite': 'dromaeojs', 05:00:15 INFO - 'system_bits': '32', 05:00:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:00:15 INFO - 'title': 'talos-linux64-ix-014', 05:00:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:00:15 INFO - 'use_talos_json': True, 05:00:15 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:00:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:00:15 INFO - 'work_dir': 'build'} 05:00:15 INFO - ##### 05:00:15 INFO - ##### Running clobber step. 05:00:15 INFO - ##### 05:00:15 INFO - Running pre-action listener: _resource_record_pre_action 05:00:15 INFO - Running main action method: clobber 05:00:15 INFO - rmtree: /builds/slave/test-pgo/build 05:00:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:00:16 INFO - Running post-action listener: _resource_record_post_action 05:00:16 INFO - ##### 05:00:16 INFO - ##### Running read-buildbot-config step. 05:00:16 INFO - ##### 05:00:16 INFO - Running pre-action listener: _resource_record_pre_action 05:00:16 INFO - Running main action method: read_buildbot_config 05:00:16 INFO - Using buildbot properties: 05:00:16 INFO - { 05:00:16 INFO - "project": "", 05:00:16 INFO - "product": "firefox", 05:00:16 INFO - "script_repo_revision": "production", 05:00:16 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 05:00:16 INFO - "repository": "", 05:00:16 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 05:00:16 INFO - "buildid": "20160412022558", 05:00:16 INFO - "pgo_build": "True", 05:00:16 INFO - "basedir": "/builds/slave/test-pgo", 05:00:16 INFO - "buildnumber": 157, 05:00:16 INFO - "slavename": "talos-linux64-ix-014", 05:00:16 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:00:16 INFO - "platform": "ubuntu64_hw", 05:00:16 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:00:16 INFO - "branch": "mozilla-aurora", 05:00:16 INFO - "repo_path": "releases/mozilla-aurora", 05:00:16 INFO - "revision": "6e8c76e38e0522e0cde432c8ecccfab501018204", 05:00:16 INFO - "stage_platform": "linux64-pgo", 05:00:16 INFO - "builduid": "5f0fd912833d468c944fbaabbcecdcdd", 05:00:16 INFO - "slavebuilddir": "test" 05:00:16 INFO - } 05:00:16 INFO - Found installer url https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2. 05:00:16 INFO - Running post-action listener: _resource_record_post_action 05:00:16 INFO - ##### 05:00:16 INFO - ##### Running download-and-extract step. 05:00:16 INFO - ##### 05:00:16 INFO - Running pre-action listener: _resource_record_pre_action 05:00:16 INFO - Running main action method: download_and_extract 05:00:16 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:16 INFO - https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:00:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:00:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:00:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:00:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:00:17 INFO - Downloaded 1448 bytes. 05:00:17 INFO - Reading from file /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.test_packages.json 05:00:17 INFO - Using the following test package requirements: 05:00:17 INFO - {u'common': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:00:17 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:00:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:00:17 INFO - u'gtest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:00:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:00:17 INFO - u'jittest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:00:17 INFO - u'jsshell-linux-x86_64.zip'], 05:00:17 INFO - u'mochitest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:00:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:00:17 INFO - u'mozbase': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:00:17 INFO - u'reftest': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:00:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:00:17 INFO - u'talos': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:00:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:00:17 INFO - u'web-platform': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:00:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:00:17 INFO - u'webapprt': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'], 05:00:17 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 05:00:17 INFO - u'firefox-47.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:00:17 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:00:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:17 INFO - https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:00:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:00:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:00:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:00:18 INFO - Downloaded 23350660 bytes. 05:00:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:00:18 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:00:20 INFO - Return code: 0 05:00:20 INFO - Downloading packages: [u'firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:00:20 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')]} 05:00:20 INFO - https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:00:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:00:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:00:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip 05:00:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:00:42 INFO - Downloaded 23350660 bytes. 05:00:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:00:42 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:00:44 INFO - Return code: 0 05:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:44 INFO - https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip 05:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:00:46 INFO - Downloaded 10845168 bytes. 05:00:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:00:46 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:00:46 INFO - Return code: 0 05:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:46 INFO - https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:00:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:00:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:00:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:00:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:00:48 INFO - Downloaded 60570683 bytes. 05:00:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:00:48 INFO - mkdir: /builds/slave/test-pgo/properties 05:00:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:00:48 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:00:48 INFO - Contents: 05:00:48 INFO - build_url:https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 05:00:49 INFO - Running post-action listener: _resource_record_post_action 05:00:49 INFO - Running post-action listener: set_extra_try_arguments 05:00:49 INFO - ##### 05:00:49 INFO - ##### Running populate-webroot step. 05:00:49 INFO - ##### 05:00:49 INFO - Running pre-action listener: _resource_record_pre_action 05:00:49 INFO - Running main action method: populate_webroot 05:00:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:49 INFO - '--tppagecycles', 05:00:49 INFO - '7'], 05:00:49 INFO - 'tests': ['tsvgm']}}, 05:00:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:00:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:00:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:00:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:00:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:00:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--e10s'], 05:00:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'tests': ['damp', 'tps']}, 05:00:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--e10s'], 05:00:49 INFO - 'tests': ['damp', 'tps']}, 05:00:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:00:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:49 INFO - 'other': {'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:00:49 INFO - 'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:00:49 INFO - 'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:00:49 INFO - 'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other_l64': {'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'other_nol64': {'tests': ['a11yr', 05:00:49 INFO - 'ts_paint', 05:00:49 INFO - 'tpaint', 05:00:49 INFO - 'sessionrestore', 05:00:49 INFO - 'sessionrestore_no_auto_restore', 05:00:49 INFO - 'tabpaint']}, 05:00:49 INFO - 'svgr': {'tests': ['tsvgx', 05:00:49 INFO - 'tsvgr_opacity', 05:00:49 INFO - 'tart', 05:00:49 INFO - 'tscrollx', 05:00:49 INFO - 'cart']}, 05:00:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:00:49 INFO - 'tests': ['tsvgx', 05:00:49 INFO - 'tsvgr_opacity', 05:00:49 INFO - 'tart', 05:00:49 INFO - 'tscrollx', 05:00:49 INFO - 'cart']}, 05:00:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'tests': ['tp5o']}, 05:00:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--e10s'], 05:00:49 INFO - 'tests': ['tp5o']}, 05:00:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--xperf_path', 05:00:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:49 INFO - 'tests': ['tp5n']}, 05:00:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:00:49 INFO - 'talos_options': ['--e10s', 05:00:49 INFO - '--xperf_path', 05:00:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:49 INFO - 'tests': ['tp5n']}}, 05:00:49 INFO - 'talos.zip': {'path': '', 05:00:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:49 INFO - Running post-action listener: _resource_record_post_action 05:00:49 INFO - ##### 05:00:49 INFO - ##### Running create-virtualenv step. 05:00:49 INFO - ##### 05:00:49 INFO - Running pre-action listener: _resource_record_pre_action 05:00:49 INFO - Running main action method: create_virtualenv 05:00:49 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:00:49 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 05:00:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:00:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:49 INFO - Using real prefix '/usr' 05:00:49 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:00:49 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:51 INFO - Installing pip.................done. 05:00:51 INFO - Return code: 0 05:00:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:51 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 0x7f7f002a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', '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 05:00:51 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 05:00:51 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 05:00:51 INFO - Using env: {'DISPLAY': ':0', 05:00:51 INFO - 'HOME': '/home/cltbld', 05:00:51 INFO - 'LANG': 'en_US.UTF-8', 05:00:51 INFO - 'LANGUAGE': 'en_US:en', 05:00:51 INFO - 'LOGNAME': 'cltbld', 05:00:51 INFO - 'MAIL': '/var/mail/cltbld', 05:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:51 INFO - 'MOZ_NO_REMOTE': '1', 05:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:51 INFO - 'NO_EM_RESTART': '1', 05:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:51 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:51 INFO - 'SHELL': '/bin/bash', 05:00:51 INFO - 'SHLVL': '1', 05:00:51 INFO - 'TERM': 'linux', 05:00:51 INFO - 'TMOUT': '86400', 05:00:51 INFO - 'USER': 'cltbld', 05:00:51 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:51 INFO - '_': '/tools/buildbot/bin/python'} 05:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:51 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 05:00:51 INFO - Cleaning up... 05:00:51 INFO - Return code: 0 05:00:51 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:52 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 0x7f7f002a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', '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 05:00:52 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 05:00:52 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 05:00:52 INFO - Using env: {'DISPLAY': ':0', 05:00:52 INFO - 'HOME': '/home/cltbld', 05:00:52 INFO - 'LANG': 'en_US.UTF-8', 05:00:52 INFO - 'LANGUAGE': 'en_US:en', 05:00:52 INFO - 'LOGNAME': 'cltbld', 05:00:52 INFO - 'MAIL': '/var/mail/cltbld', 05:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:52 INFO - 'MOZ_NO_REMOTE': '1', 05:00:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:52 INFO - 'NO_EM_RESTART': '1', 05:00:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:52 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:52 INFO - 'SHELL': '/bin/bash', 05:00:52 INFO - 'SHLVL': '1', 05:00:52 INFO - 'TERM': 'linux', 05:00:52 INFO - 'TMOUT': '86400', 05:00:52 INFO - 'USER': 'cltbld', 05:00:52 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:52 INFO - '_': '/tools/buildbot/bin/python'} 05:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:52 INFO - Downloading/unpacking psutil>=0.7.1 05:00:52 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 05:00:52 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 05:00:52 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 05:00:52 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 05:00:52 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 05:00:52 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 05:00:54 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:54 INFO - Installing collected packages: psutil 05:00:54 INFO - Running setup.py install for psutil 05:00:54 INFO - building 'psutil._psutil_linux' extension 05:00:54 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 05:00:54 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 05:00:54 INFO - building 'psutil._psutil_posix' extension 05:00:54 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 05:00:54 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 05:00:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:54 INFO - Successfully installed psutil 05:00:54 INFO - Cleaning up... 05:00:54 INFO - Return code: 0 05:00:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:00: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')]} 05:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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', '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 0x7f7f002a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', '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 05:00: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:00: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 mozsystemmonitor==0.0.0 05:00:54 INFO - Using env: {'DISPLAY': ':0', 05:00:54 INFO - 'HOME': '/home/cltbld', 05:00:54 INFO - 'LANG': 'en_US.UTF-8', 05:00:54 INFO - 'LANGUAGE': 'en_US:en', 05:00:54 INFO - 'LOGNAME': 'cltbld', 05:00:54 INFO - 'MAIL': '/var/mail/cltbld', 05:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:54 INFO - 'MOZ_NO_REMOTE': '1', 05:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:54 INFO - 'NO_EM_RESTART': '1', 05:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:54 INFO - 'SHELL': '/bin/bash', 05:00:54 INFO - 'SHLVL': '1', 05:00:54 INFO - 'TERM': 'linux', 05:00:54 INFO - 'TMOUT': '86400', 05:00:54 INFO - 'USER': 'cltbld', 05:00:54 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:54 INFO - '_': '/tools/buildbot/bin/python'} 05:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:54 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:00:56 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:00:56 INFO - Installing collected packages: mozsystemmonitor 05:00:56 INFO - Running setup.py install for mozsystemmonitor 05:00:56 INFO - Successfully installed mozsystemmonitor 05:00:56 INFO - Cleaning up... 05:00:57 INFO - Return code: 0 05:00:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:00: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')]} 05:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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', '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 0x7f7f002a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', '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 05:00: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:00: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 blobuploader==1.2.4 05:00:57 INFO - Using env: {'DISPLAY': ':0', 05:00:57 INFO - 'HOME': '/home/cltbld', 05:00:57 INFO - 'LANG': 'en_US.UTF-8', 05:00:57 INFO - 'LANGUAGE': 'en_US:en', 05:00:57 INFO - 'LOGNAME': 'cltbld', 05:00:57 INFO - 'MAIL': '/var/mail/cltbld', 05:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:57 INFO - 'MOZ_NO_REMOTE': '1', 05:00:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:00:57 INFO - 'NO_EM_RESTART': '1', 05:00:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:00:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:00:57 INFO - 'SHELL': '/bin/bash', 05:00:57 INFO - 'SHLVL': '1', 05:00:57 INFO - 'TERM': 'linux', 05:00:57 INFO - 'TMOUT': '86400', 05:00:57 INFO - 'USER': 'cltbld', 05:00:57 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:57 INFO - '_': '/tools/buildbot/bin/python'} 05:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:59 INFO - Downloading blobuploader-1.2.4.tar.gz 05:00:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:00:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:00:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00: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 05:00:59 INFO - Downloading docopt-0.6.1.tar.gz 05:00:59 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:00:59 INFO - Installing collected packages: blobuploader, requests, docopt 05:00:59 INFO - Running setup.py install for blobuploader 05:00:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:00:59 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:00:59 INFO - Running setup.py install for requests 05:01:00 INFO - Running setup.py install for docopt 05:01:00 INFO - Successfully installed blobuploader requests docopt 05:01:00 INFO - Cleaning up... 05:01:00 INFO - Return code: 0 05:01:00 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:01:00 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')]} 05:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:00 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')]} 05:01:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:00 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 0x7f7f002a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', '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 05:01:00 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 05:01:00 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 05:01:00 INFO - Using env: {'DISPLAY': ':0', 05:01:00 INFO - 'HOME': '/home/cltbld', 05:01:00 INFO - 'LANG': 'en_US.UTF-8', 05:01:00 INFO - 'LANGUAGE': 'en_US:en', 05:01:00 INFO - 'LOGNAME': 'cltbld', 05:01:00 INFO - 'MAIL': '/var/mail/cltbld', 05:01:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:00 INFO - 'MOZ_NO_REMOTE': '1', 05:01:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:00 INFO - 'NO_EM_RESTART': '1', 05:01:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:00 INFO - 'SHELL': '/bin/bash', 05:01:00 INFO - 'SHLVL': '1', 05:01:00 INFO - 'TERM': 'linux', 05:01:00 INFO - 'TMOUT': '86400', 05:01:00 INFO - 'USER': 'cltbld', 05:01:00 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:01:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:00 INFO - '_': '/tools/buildbot/bin/python'} 05:01:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:00 INFO - Running setup.py (path:/tmp/pip-4oKzzZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:00 INFO - Running setup.py (path:/tmp/pip-7kvfbn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:00 INFO - Running setup.py (path:/tmp/pip-eX1mXq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:00 INFO - Running setup.py (path:/tmp/pip-xFA2ax-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:00 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:00 INFO - Running setup.py (path:/tmp/pip-mjQ15e-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:01 INFO - Running setup.py (path:/tmp/pip-07QX5a-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:01 INFO - Running setup.py (path:/tmp/pip-SvDF7d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:01 INFO - Running setup.py (path:/tmp/pip-9Ya8pT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:01 INFO - Running setup.py (path:/tmp/pip-RgMkhu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:01 INFO - Running setup.py (path:/tmp/pip-703IYF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:01 INFO - Running setup.py (path:/tmp/pip-jVcpzP-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:01 INFO - Running setup.py (path:/tmp/pip-Mg6teE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:01 INFO - Running setup.py (path:/tmp/pip-WKFEuL-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:01 INFO - Running setup.py (path:/tmp/pip-fxSKMF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:01 INFO - Running setup.py (path:/tmp/pip-mQeT8G-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:01 INFO - Running setup.py (path:/tmp/pip-M7wspn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:01 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:01 INFO - Running setup.py (path:/tmp/pip-yBVmCv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:01 INFO - Running setup.py install for manifestparser 05:01:01 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:01:01 INFO - Running setup.py install for mozcrash 05:01:02 INFO - Running setup.py install for mozdebug 05:01:02 INFO - Running setup.py install for mozdevice 05:01:02 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:01:02 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:01:02 INFO - Running setup.py install for mozfile 05:01:02 INFO - Running setup.py install for mozhttpd 05:01:02 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:01:02 INFO - Running setup.py install for mozinfo 05:01:02 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:01:02 INFO - Running setup.py install for mozInstall 05:01:02 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:01:02 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:01:02 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:01:02 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:01:02 INFO - Running setup.py install for mozleak 05:01:02 INFO - Running setup.py install for mozlog 05:01:02 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:01:02 INFO - Running setup.py install for moznetwork 05:01:03 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:01:03 INFO - Running setup.py install for mozprocess 05:01:03 INFO - Running setup.py install for mozprofile 05:01:03 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:01:03 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:01:03 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:01:03 INFO - Running setup.py install for mozrunner 05:01:03 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:01:03 INFO - Running setup.py install for mozscreenshot 05:01:03 INFO - Running setup.py install for moztest 05:01:03 INFO - Running setup.py install for mozversion 05:01:03 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:01:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:01:03 INFO - Cleaning up... 05:01:03 INFO - Return code: 0 05:01:03 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:03 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 0x7f7f002a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', '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 05:01:03 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 05:01:03 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 05:01:03 INFO - Using env: {'DISPLAY': ':0', 05:01:03 INFO - 'HOME': '/home/cltbld', 05:01:03 INFO - 'LANG': 'en_US.UTF-8', 05:01:03 INFO - 'LANGUAGE': 'en_US:en', 05:01:03 INFO - 'LOGNAME': 'cltbld', 05:01:03 INFO - 'MAIL': '/var/mail/cltbld', 05:01:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:03 INFO - 'MOZ_NO_REMOTE': '1', 05:01:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:03 INFO - 'NO_EM_RESTART': '1', 05:01:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:03 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:03 INFO - 'SHELL': '/bin/bash', 05:01:03 INFO - 'SHLVL': '1', 05:01:03 INFO - 'TERM': 'linux', 05:01:03 INFO - 'TMOUT': '86400', 05:01:03 INFO - 'USER': 'cltbld', 05:01:03 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:01:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:03 INFO - '_': '/tools/buildbot/bin/python'} 05:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:03 INFO - Running setup.py (path:/tmp/pip-fs8TrI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:01:03 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)) 05:01:03 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:03 INFO - Running setup.py (path:/tmp/pip-rPyYGg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:04 INFO - Running setup.py (path:/tmp/pip-XKp2Mb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:04 INFO - Running setup.py (path:/tmp/pip-U9EUxl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:04 INFO - Running setup.py (path:/tmp/pip-b1f6Qe-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:04 INFO - Running setup.py (path:/tmp/pip-QYKvw3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:04 INFO - Running setup.py (path:/tmp/pip-C2cAbc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:04 INFO - Running setup.py (path:/tmp/pip-IB26Zz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:04 INFO - Running setup.py (path:/tmp/pip-OULG29-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:04 INFO - Running setup.py (path:/tmp/pip-U9y2jW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:04 INFO - Running setup.py (path:/tmp/pip-281OL0-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:04 INFO - Running setup.py (path:/tmp/pip-4iGVpk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:04 INFO - Running setup.py (path:/tmp/pip-2tUGIA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:04 INFO - Running setup.py (path:/tmp/pip-4a4BKs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:04 INFO - Running setup.py (path:/tmp/pip-DGxIqw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:01:04 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)) 05:01:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:04 INFO - Running setup.py (path:/tmp/pip-tMLZdh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:01:05 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)) 05:01:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:05 INFO - Running setup.py (path:/tmp/pip-vaIY_L-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:01:05 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)) 05:01:05 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:05 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.17->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:05 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)) 05:01:05 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:05 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.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:05 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 05:01:05 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 05:01:05 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 05:01:05 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 05:01:05 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 05:01:05 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 05:01:06 INFO - Downloading blessings-1.6.tar.gz 05:01:06 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:01:07 INFO - Installing collected packages: blessings 05:01:07 INFO - Running setup.py install for blessings 05:01:07 INFO - Successfully installed blessings 05:01:07 INFO - Cleaning up... 05:01:07 INFO - Return code: 0 05:01:07 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:01:07 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:01:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:01:07 INFO - Reading from file tmpfile_stdout 05:01:07 INFO - Current package versions: 05:01:07 INFO - argparse == 1.2.1 05:01:07 INFO - blessings == 1.6 05:01:07 INFO - blobuploader == 1.2.4 05:01:07 INFO - docopt == 0.6.1 05:01:07 INFO - manifestparser == 1.1 05:01:07 INFO - mozInstall == 1.12 05:01:07 INFO - mozcrash == 0.17 05:01:07 INFO - mozdebug == 0.1 05:01:07 INFO - mozdevice == 0.48 05:01:07 INFO - mozfile == 1.2 05:01:07 INFO - mozhttpd == 0.7 05:01:07 INFO - mozinfo == 0.9 05:01:07 INFO - mozleak == 0.1 05:01:07 INFO - mozlog == 3.1 05:01:07 INFO - moznetwork == 0.27 05:01:07 INFO - mozprocess == 0.22 05:01:07 INFO - mozprofile == 0.28 05:01:07 INFO - mozrunner == 6.11 05:01:07 INFO - mozscreenshot == 0.1 05:01:07 INFO - mozsystemmonitor == 0.0 05:01:07 INFO - moztest == 0.7 05:01:07 INFO - mozversion == 1.4 05:01:07 INFO - psutil == 3.1.1 05:01:07 INFO - requests == 1.2.3 05:01:07 INFO - wsgiref == 0.1.2 05:01:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:07 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 0x7f7f002a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', '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 05:01:07 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 05:01:07 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 05:01:07 INFO - Using env: {'DISPLAY': ':0', 05:01:07 INFO - 'HOME': '/home/cltbld', 05:01:07 INFO - 'LANG': 'en_US.UTF-8', 05:01:07 INFO - 'LANGUAGE': 'en_US:en', 05:01:07 INFO - 'LOGNAME': 'cltbld', 05:01:07 INFO - 'MAIL': '/var/mail/cltbld', 05:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:07 INFO - 'MOZ_NO_REMOTE': '1', 05:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:07 INFO - 'NO_EM_RESTART': '1', 05:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:07 INFO - 'SHELL': '/bin/bash', 05:01:07 INFO - 'SHLVL': '1', 05:01:07 INFO - 'TERM': 'linux', 05:01:07 INFO - 'TMOUT': '86400', 05:01:07 INFO - 'USER': 'cltbld', 05:01:07 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:07 INFO - '_': '/tools/buildbot/bin/python'} 05:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.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 1)) 05:01:07 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 2)) 05:01:07 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 3)) 05:01:07 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 4)) 05:01:07 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 5)) 05:01:07 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 6)) 05:01:07 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 7)) 05:01:07 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 8)) 05:01:07 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 9)) 05:01:07 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.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:01: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:01:07 INFO - Cleaning up... 05:01:07 INFO - Return code: 0 05:01:07 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:07 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 0x7f7f002a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', '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 05:01:07 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 05:01:07 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 05:01:07 INFO - Using env: {'DISPLAY': ':0', 05:01:07 INFO - 'HOME': '/home/cltbld', 05:01:07 INFO - 'LANG': 'en_US.UTF-8', 05:01:07 INFO - 'LANGUAGE': 'en_US:en', 05:01:07 INFO - 'LOGNAME': 'cltbld', 05:01:07 INFO - 'MAIL': '/var/mail/cltbld', 05:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:07 INFO - 'MOZ_NO_REMOTE': '1', 05:01:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:07 INFO - 'NO_EM_RESTART': '1', 05:01:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:07 INFO - 'SHELL': '/bin/bash', 05:01:07 INFO - 'SHLVL': '1', 05:01:07 INFO - 'TERM': 'linux', 05:01:07 INFO - 'TMOUT': '86400', 05:01:07 INFO - 'USER': 'cltbld', 05:01:07 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:07 INFO - '_': '/tools/buildbot/bin/python'} 05:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:07 INFO - Downloading/unpacking jsonschema 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:01:09 INFO - Downloading/unpacking functools32 (from jsonschema) 05:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:01:09 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:01:10 INFO - warning: no files found matching '*.txt' 05:01:10 INFO - no previously-included directories found matching 'build' 05:01:10 INFO - no previously-included directories found matching 'dist' 05:01:10 INFO - no previously-included directories found matching '.git*' 05:01:10 INFO - Installing collected packages: jsonschema, functools32 05:01:10 INFO - Running setup.py install for functools32 05:01:10 INFO - warning: no files found matching '*.txt' 05:01:10 INFO - no previously-included directories found matching 'build' 05:01:10 INFO - no previously-included directories found matching 'dist' 05:01:10 INFO - no previously-included directories found matching '.git*' 05:01:10 INFO - Successfully installed jsonschema functools32 05:01:10 INFO - Cleaning up... 05:01:10 INFO - Return code: 0 05:01:10 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:01: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')]} 05:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f7f002a1f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd008a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xdcd6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, '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': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', '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 05:01: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', 'flake8'] in /builds/slave/test-pgo/build 05:01: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 flake8 05:01:10 INFO - Using env: {'DISPLAY': ':0', 05:01:10 INFO - 'HOME': '/home/cltbld', 05:01:10 INFO - 'LANG': 'en_US.UTF-8', 05:01:10 INFO - 'LANGUAGE': 'en_US:en', 05:01:10 INFO - 'LOGNAME': 'cltbld', 05:01:10 INFO - 'MAIL': '/var/mail/cltbld', 05:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:10 INFO - 'MOZ_NO_REMOTE': '1', 05:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:10 INFO - 'NO_EM_RESTART': '1', 05:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:10 INFO - 'SHELL': '/bin/bash', 05:01:10 INFO - 'SHLVL': '1', 05:01:10 INFO - 'TERM': 'linux', 05:01:10 INFO - 'TMOUT': '86400', 05:01:10 INFO - 'USER': 'cltbld', 05:01:10 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:10 INFO - '_': '/tools/buildbot/bin/python'} 05:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:10 INFO - Downloading/unpacking flake8 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:01:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:01:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01: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 05:01:12 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:01:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:01:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:01:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:01:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:01:13 INFO - no previously-included directories found matching 'docs/_build' 05:01:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:01:13 INFO - Running setup.py install for pep8 05:01:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:01:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:01:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:01:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:01:13 INFO - no previously-included directories found matching 'docs/_build' 05:01:13 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:01:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:01:13 INFO - Cleaning up... 05:01:13 INFO - Return code: 0 05:01:13 INFO - Running post-action listener: _resource_record_post_action 05:01:13 INFO - Running post-action listener: _start_resource_monitoring 05:01:13 INFO - Starting resource monitoring. 05:01:13 INFO - ##### 05:01:13 INFO - ##### Running install step. 05:01:13 INFO - ##### 05:01:13 INFO - Running pre-action listener: _resource_record_pre_action 05:01:13 INFO - Running main action method: install 05:01:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:01:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:01:13 INFO - Reading from file tmpfile_stdout 05:01:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:01:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:01:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:01:13 INFO - Reading from file tmpfile_stdout 05:01:13 INFO - Output received: 05:01:13 INFO - Usage: mozinstall [options] installer 05:01:13 INFO - Options: 05:01:13 INFO - -h, --help show this help message and exit 05:01:13 INFO - -d DEST, --destination=DEST 05:01:13 INFO - Directory to install application into. [default: 05:01:13 INFO - "/builds/slave/test-pgo"] 05:01:13 INFO - --app=APP Application being installed. [default: firefox] 05:01:13 INFO - mkdir: /builds/slave/test-pgo/build/application 05:01:13 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:01:13 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:01:28 INFO - Reading from file tmpfile_stdout 05:01:28 INFO - Output received: 05:01:28 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:01:28 INFO - Running post-action listener: _resource_record_post_action 05:01:28 INFO - ##### 05:01:28 INFO - ##### Running run-tests step. 05:01:28 INFO - ##### 05:01:28 INFO - Running pre-action listener: _resource_record_pre_action 05:01:28 INFO - Running main action method: run_tests 05:01:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:01:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:01:28 INFO - Python 2.7.3 05:01:28 INFO - Return code: 0 05:01:28 INFO - grabbing minidump binary from tooltool 05:01:28 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')]} 05:01:28 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 0xe5c920>, '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 0xe5d820>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe5dcb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:01:28 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 05:01:28 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 05:01:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:01:28 INFO - Return code: 0 05:01:28 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:01:28 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:01:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:01:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:01:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:01:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:01:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:01:29 INFO - Return code: 0 05:01:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 05:01:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-014 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 05:01:29 INFO - Using env: {'DISPLAY': ':0', 05:01:29 INFO - 'HOME': '/home/cltbld', 05:01:29 INFO - 'LANG': 'en_US.UTF-8', 05:01:29 INFO - 'LANGUAGE': 'en_US:en', 05:01:29 INFO - 'LOGNAME': 'cltbld', 05:01:29 INFO - 'MAIL': '/var/mail/cltbld', 05:01:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:01:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:01:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:29 INFO - 'MOZ_NO_REMOTE': '1', 05:01:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:01:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:01:29 INFO - 'NO_EM_RESTART': '1', 05:01:29 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:01:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:01:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:01:29 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:01:29 INFO - 'SHELL': '/bin/bash', 05:01:29 INFO - 'SHLVL': '1', 05:01:29 INFO - 'TERM': 'linux', 05:01:29 INFO - 'TMOUT': '86400', 05:01:29 INFO - 'USER': 'cltbld', 05:01:29 INFO - 'XDG_SESSION_COOKIE': 'fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559', 05:01:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:29 INFO - '_': '/tools/buildbot/bin/python'} 05:01:29 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-014', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:01:30 INFO - mozversion application_buildid: 20160412022558 05:01:30 INFO - mozversion application_changeset: 6e8c76e38e0522e0cde432c8ecccfab501018204 05:01:30 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:01:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:01:30 INFO - mozversion application_name: Firefox 05:01:30 INFO - mozversion application_remotingname: firefox-dev 05:01:30 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:01:30 INFO - mozversion application_vendor: Mozilla 05:01:30 INFO - mozversion application_version: 47.0a2 05:01:30 INFO - mozversion platform_buildid: 20160412022558 05:01:30 INFO - mozversion platform_changeset: 6e8c76e38e0522e0cde432c8ecccfab501018204 05:01:30 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:01:30 INFO - mozversion platform_version: 47.0a2 05:01:30 INFO - using testdate: 1460462490 05:01:30 INFO - actual date: 1460462490 05:01:30 INFO - starting webserver on 'localhost:32945' 05:01:30 INFO - SUITE-START | Running 2 tests 05:01:30 INFO - TEST-START | dromaeo_css 05:01:30 INFO - operating with platform_type : linux_ 05:01:30 INFO - Initialising browser for dromaeo_css test... 05:01:30 INFO - TEST-INFO | started process 30835 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2QQmzB/profile http://localhost:32945/getInfo.html) 05:01:34 INFO - PROCESS | 30835 | __metrics Screen width/height:1600/1200 05:01:34 INFO - PROCESS | 30835 | colorDepth:24 05:01:34 INFO - PROCESS | 30835 | Browser inner width/height: 1024/697 05:01:34 INFO - PROCESS | 30835 | __metrics 05:01:35 INFO - PROCESS | 30835 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:36 INFO - TEST-INFO | 30835: exit 0 05:01:36 INFO - Browser initialized. 05:01:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:01:36 INFO - TEST-INFO | started process 30925 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmp2QQmzB/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:48 INFO - PROCESS | 30925 | RSS: Main: 141746176 05:01:48 INFO - PROCESS | 30925 | 05:02:39 INFO - PROCESS | 30925 | 1460462559348 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] 05:04:46 INFO - PROCESS | 30925 | Cycle 1(1): loaded http://localhost:32945/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32945/tests/dromaeo/cssquery-ext.html) 05:04:48 INFO - PROCESS | 30925 | RSS: Main: 254943232 05:04:48 INFO - PROCESS | 30925 | 05:07:50 INFO - PROCESS | 30925 | Cycle 1(1): loaded http://localhost:32945/tests/dromaeo/cssquery-ext.html (next: http://localhost:32945/tests/dromaeo/cssquery-jquery.html) 05:07:50 INFO - PROCESS | 30925 | RSS: Main: 223301632 05:07:50 INFO - PROCESS | 30925 | 05:10:52 INFO - PROCESS | 30925 | Cycle 1(1): loaded http://localhost:32945/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32945/tests/dromaeo/cssquery-mootools.html) 05:10:53 INFO - PROCESS | 30925 | RSS: Main: 217088000 05:10:53 INFO - PROCESS | 30925 | 05:13:55 INFO - PROCESS | 30925 | Cycle 1(1): loaded http://localhost:32945/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32945/tests/dromaeo/cssquery-prototype.html) 05:13:55 INFO - PROCESS | 30925 | RSS: Main: 211255296 05:13:55 INFO - PROCESS | 30925 | 05:16:58 INFO - PROCESS | 30925 | Cycle 1(1): loaded http://localhost:32945/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32945/tests/dromaeo/cssquery-yui.html) 05:16:58 INFO - PROCESS | 30925 | RSS: Main: 208871424 05:16:58 INFO - PROCESS | 30925 | 05:20:01 INFO - PROCESS | 30925 | Cycle 1(1): loaded http://localhost:32945/tests/dromaeo/cssquery-yui.html (next: http://localhost:32945/tests/dromaeo/cssquery-dojo.html) 05:20:01 INFO - PROCESS | 30925 | RSS: Main: 257339392 05:20:01 INFO - PROCESS | 30925 | 05:20:01 INFO - PROCESS | 30925 | __start_tp_report 05:20:01 INFO - PROCESS | 30925 | _x_x_mozilla_page_load 05:20:01 INFO - PROCESS | 30925 | _x_x_mozilla_page_load_details 05:20:01 INFO - PROCESS | 30925 | |i|pagename|runs| 05:20:01 INFO - PROCESS | 30925 | |0;dojo.html;3256.527803468497;3312.0726196664914;3341.181410554413;3347.6819702128305;3382.272811345561;5356.169793681981;5363.785448582052;5363.973180134099;5383.192521121834;5392.2181283713835;5338.599605029619;5346;5362.195670649405;5372.865678358043;5376.946230537694;4803.711777293356;4908.558229759321;4923.556879880819;4938.950610493885;4981.476944920785;4807.038592281558;4871.5615594596475;4956.603471722272;4987.376577927759;5064.366954130734;4977.751112444382;5006.474320196364;5015.297858299841;5016.247562865563;5034.295198672189;4750.548697873696;4940.3330550375595;4973.353464049686;4991.32617096691;5009.499050094998;4813.085513752376;4873.488283730193;4874.073925954093;4877.463479017305;4914.4839791821705;5141.048905952411;5149.922751158736;5157.535821776059;5166.095933211711;5183.948160518385;5687.829365119053;5716.799912003102;5720.027595308808;5724.227229324029;5742.368339482654;5689.260396148516;5708.828735137952;5734.856628584319;5739.598228124033;5763.221965034709;5334.413214546396;5336.946630533684;5337.306150200527;5341.946580534183;5342.1452567589;5754.942450575524;5781.392953739797;5791.594588378857;5854.912176317359;5902.085176797603;5639.774409023676;5641.633293835887;5650.660960342392;5651.406602306781;5654.151877218368;5709.34342550612;5747.3677895431465;5754.0505816540635;5767.077267637158;5772.740226689809;5676.971615141898;5713.2572765541045;5763.538916886639;5857.472827445466;5871.4128587141795;5702.857428564319;5712.485876271156;5719.656820590778;5720.08478643415;5724.427557244326;4303.569643035671;4324.545922678073;4334.45819272591;4337.414449049338;4360;3834.9616503835164;3921.2353591049473;3946.4869566956113;3961.544422391404;3974.9205015900097;5478.671279723229;5512.366077901012;5517.282753242052;5518.613697041249;5541.418151094077;5703.885922281531;5806.506446951972;5809.7095145242565;5811.186433899257;5818.301803783488;5397.865053373697;5460.6996615186545;5474.616776825584;5495.6153069285565;5511.118221084687;4915.557599816034;4928.827491037868;4934.55588996992;4938.703677779345;4964.379452568429;5936.851578710567;5940.34656187819;5946.108083787466;5949.405059494103;6051.122587224828;5793.478586927196;5794.0439827428;5796.21751063601;5804.187413762161;5807.622504537191;6037.335893051673;6054.303755068224;6054.424829641177;6057.394260573908;6061.454469097803;5452.991196628636;5715.657060576379;5732.426757324234;5733.881893030819;5780.959427303126;5785.016547187072;5792.3917988612275;5795.913061304;5799.710014499343;5816.331121921034;5634;5659.688717120598;5663.716814159358;5666.575006874418;5668.149777533238;5465.918011229915;5643.209950607001;5648.689322087324;5747.7413516391025;5773.624714393551;5500.092484739973;5509.834704958857;5550.639208451437;5550.916736248879;5573.637713548606;5628.324601047901;5657.12314591239;5668.319801623831;5674.858128546819;5678.6876721779045;5383.703896285742;5465.562754979672;5524.475174858382;5592.636478628876;5616.297962754656 05:20:01 INFO - PROCESS | 30925 | |1;ext.html;522.8039485193055;525.3931708876247;535.1117145538406;557.6208178438662;573.1088157914446;39686.40470392947;40747.796261018724;40883.97790055246;40920.18159636809;40944.38583421244;43947.78026109873;44212;44257.33613995793;44601.553984460144;44625.553744462544;8976.640934362635;9184.540772961358;9189.678361257358;9191.586378612945;9194.12655797698;8932.374733768638;9078.409903356294;9085.682001129962;9094.909050909506;9100.863487047667;9295.442273463614;9371.34400591959;9384.483853388061;9385.155336019758;9388.906110938871;9256.537173141349;9317.767055823591;9332;9338.159565639091;9346.018668039895;9174.587143578556;9291.907080929172;9299.76750581234;9300.813983720287;9319.021502742182;44450.33324500135;44892.3266151008;44999.55000450019;45000.77499612514;45053.32420013702;1813.8820976636475;3574.5174401455993;3923.5487918889407;3924.6664033556895;4022.4971878515184;33525;33532.664673353196;33598;33918.6608133918;34728.30543389143;3990.182012687392;4001.279769641463;4019.6985226107868;4076.164386300801;4092.856750013765;300021;301060;301201;303537;303741.9999999978;46129.538704612525;47059.76470117696;60547.39452605505;60740;60807.69596151991;48860.75569622129;48969;49165.75417122892;49195.262071068966;49232.50767492351;16950.915245423694;17233.741493877602;17257.3959911405;17262.82737172612;17265.482035538953;12269.938650306869;12322.075844311712;12323;12357.814632780515;12363.93818030904;15719;15882.285297161656;15887.920560397124;15895.125768082635;15942.20288985546;5677.403872593401;5731.014017804537;5756.539476841926;5819.970900145557;5875.6474611523445;926.7219834049758;989.8023391696129;1031.8443343455378;1053.5733028123623;1112.0158659586164;28698.569521457193;28703.42593148125;28767.856160719482;29412.264693382836;29759;986.7483791633088;1082.3992684060422;1106.4578356605205;1131.6191509373043;1223.6879595703217;16235.431759888348;16236.1070141141;16316.510504684878;16354.345826167058;16910.239039243264;395534;410522;411391;412087;412107;62063.37936620666;62344.37655623476;62593.68703156455;62640;62705.68647156735;1300.1419063418098;1339.1295657822493;1404.515442172449;1414.6684557866076;1433.813604231464;28234;29076.27309317284;29484.410311793214;29948;30379.392412152076;44032.77983610061;44811.55188448204;44885.77557112324;44898.551014490746;44899.551004490844;216473;246549;246781;246898;247289;29650.962216322325;34335.65664343325;34934.30131397307;35482.46776298306;35694.64305356913;52517.474825252786;52669.736651316496;52915.73542132265;53083.20375194298;54276;40509.39235911405;40696.3895541573;40948.38577421282;41014.589854101076;42150.15699685928;39717.2056558873;40370.79814600908;40606.79696601498;41086.178276434905;41199.58800412077;39581.40627890641;39966.600333996284;40656.79671601623;41072.79463602663;41275;34129;35682.28635427329;36088;36577.45133823048;36688.08279793026;27647.44705105927;27880.721192787812;27903.720962790114;27977.44045119127;28301.292467688472 05:20:01 INFO - PROCESS | 30925 | |2;jquery.html;357.26581874248427;357.8103605089302;364.28599944109544;377.42631200575124;379.25287184247026;17343.82656173438;18058.638827223465;19652.410427687155;19657.213711451524;19691.113899874523;17754.112294385293;18561.721574176398;18664.720029199572;18724.876507409565;18726.157322920466;5523.309586301722;5758.395368486312;5772.393898640646;5783.652980821164;5784.508316793078;4235.449391579105;5614.382417934024;5968.79109231177;6237.563370564062;6281.120643109968;6118.755249790003;6146.6312021278645;6221.9688901555655;6227.3772622737815;6238.344973777756;5835.387284335147;5946.940530594682;5964.7315870785915;5966.642001479925;5967.075103358986;3845.8653947111998;5242.528172464458;5296.25852380667;5471.206675032098;5484.725763711798;21706.674399884014;21728.13087476499;21744.565108697738;22163.224287150035;22225.44436389087;2463.8768061596847;2500.374906273432;2515.1699939020077;2515.76100270474;2534.4931013797313;13410.530631427951;13727.588172354845;13750.174989500561;13864.930675346559;13940.860591394057;1893.280553389717;1918.6162767446426;1924.70167124096;2015.4961259685078;2021.6057868715607;66494;68949.31050689479;69439.65280173566;69845.65077174582;71126.64436677784;9620.567074481665;9697.806043879084;9879.209663226924;9939.50302484873;10000.2999790014;13484.865151348557;13544.187348759106;13557.118787278796;13560.118592291667;13579.45682172702;7598.164201937782;7639.809004774814;7652.196519365387;7660.1573826879;7697.230276972258;7724.7682569523;7744.883826742604;7773.727919522789;7837.137914829478;7873.881891771628;4301.161273551627;4367.868963931087;4404.141192467502;4407.801648925806;4417.580329868657;1800.522861441719;1832.2145313223127;1842.912681517884;1898.7057006164066;1932.285054529805;955.2501286490211;956.9425834449955;1015.1117771949545;1019.3527110285022;1069.0859315285475;17009.91495042517;17052.317907283817;17156.485305440856;17310.480685579452;17787.73318400225;982.5676702250987;995.1392045880406;1023.518946095334;1025.1491262252312;1047.6961681112543;9987.80024399508;10069.345492542961;10120.342177758423;10135.189184865194;10167.762131426087;388976;395958;396712;397168;397862;74088;76658;77558.22441775622;78050;78330;990.6780296403698;1009.3035805294323;1012.5696578954063;1015.0255754475786;1046.4401545173296;15482.767758483857;15484.845151548341;15535.533933981998;15537.145456999973;15685.764713529534;33256.33487330288;33854.66145338515;35002.29995400129;35511.46732799062;35763.10592235111;48324;49229.261561075895;49291.26063109128;49899.501004989484;52312.738436307576;7925.762227133196;8145.51126932386;8206.384521160817;8332.125126861592;8642.870356944777;9885.802283954425;13594.86405135936;13615.183089014294;13787.586372408843;13854.376553054935;11823.054155667698;11984.58053968107;12055.21641093326;12104.878951210376;12208.816867746813;11807.291562505934;12023.4589443477;12111.394430278628;12314.630561083182;12395.876041239471;11145.164112691742;11596.76806463849;11830.349330786888;11970.162088653711;12384;8561.44350617208;8602.483850968962;8661.480311181349;8706.912930870863;8737.082606326245;11071.833922491009;11435.485403156712;11694.2983420995;11776.70558236051;11930.76138477243 05:20:01 INFO - PROCESS | 30925 | |3;mootools.html;1433.8279406471224;1525.5575882993928;1530.18899983009;1744.4592176425308;1876.5190571489895;8072;8405.495670259788;8409.327253819694;8410.95794521028;8461.746147615582;8257.504549727006;8375.706850260241;8378.958105209465;8391.076981532027;8395;2166.8483206175574;2213.7454192767796;2402.4474370894704;2414.2877851033986;2445.510897820434;2425.454272788626;2433.610622300432;2437.049550675229;2439.829211955164;2440.1459489178824;2317.9420514487188;2353.470469144446;2365.254944692425;2370.004598068815;2372.7508611595795;2136.4445244236454;2320.8375413721046;2400.3999000249937;2431.6960379952507;2439.865807380593;2305.7348404933314;2349.259983105316;2350.764923507653;2353.8469999450153;2358.646203069536;8183.71357002502;8227.177282271785;8238.83522329556;8244.093149753522;8259;4953.182724850395;5066.594672426197;5073.518015788494;5075.187969924795;5077.314562534048;3041.65021022583;3167.255694911694;3189.378071276079;3193.6327322357993;3200.567923330344;1043.88517263101;1043.88517263101;1056.2395075545671;1063.3619828103153;1078.3152698036724;11928.58249961256;12044.578439754567;12048.277103373737;12064.819027714591;12069.758604827854;4296.37702533131;4485.798139083749;4633.606143477775;4684.180268453007;4684.789184486706;10153;10153.64462243818;10168.847467287997;10192.847107293397;10194.643187488551;5146;5195.272661827347;5199.558037566773;5201.323827902348;5208.296879921162;4088.1823635273063;4220.451341325608;4700.459447163552;4712.293156026555;4762.071396077731;3887.494625698641;3925.293447179478;3927.7446965947124;3943.901402464904;3992.341263691458;1237.1834589171103;1244.2285782814713;1255.3974092435499;1278.520554791953;1293.5989843148654;1401.5304872867703;1412.7033323002079;1424.7862820576788;1425.415579612354;1447.269129089824;8154.633041513146;8203.548804815793;8229.177082291722;8243.093259741423;8245.175482451827;516.654661069579;534.6017217173231;535.7428434351533;536.8469986053956;544.4528249109619;6261.655608941552;6263.749450022039;6267.310595834455;6281.371862813773;6323.114763933053;10090.646827361006;10359.171266298677;10573.62992295266;10577.788444231226;10592.576296948037;10106.242031847642;10300.896991029993;10360.689179324632;10365.533550990223;10459.424731639681;8071.5157090573575;8168.673253069811;8203.261706446448;8204.343652507905;8235.629396677165;7857.528548287121;7933.444658873824;7940.483868548526;7943.563104029334;8023.1174570796;9258.074192580958;9296.302777291596;9418.4819834907;9512.714618561455;9541.188998935168;9504.097110774464;9553.856692149484;9772.511374431107;9833.754156146153;9848.458334791656;6637.834054148685;6799.490038247052;7142.321479459443;7347.595882226315;7446.106467223968;7773.727919522789;7804.141544430222;7808.41436892224;7815.29662330393;7828.84342313162;7080.221175670775;7198.676059577227;7227.1327440707455;7314.926850731425;7334.3032411920785;6856.108705868404;6924.4460443165435;6947.23580406165;6977.755778547727;7039.19049309336;7264.418846492374;7420.814479638052;7443.441741869273;7443.851122977402;7511.3615342696485;6974.79075627732;6989.091418115816;6996;7009.264027277266;7013.05323781283;7117.395021423237;7119.786406407816;7241.493095483476;7265;7265.09186351706 05:20:01 INFO - PROCESS | 30925 | |4;prototype.html;344.844819831076;347.08542989223395;354.79776527379386;357.87116638010326;363.61820088906643;5895.380984996573;5922.052471604544;5951.642901425917;5957.910631340523;5974.3428222895445;5885.823425297237;5886.529077673787;5889.823305300837;5903.26209223847;5910.231669882909;4407.18467083589;4522.140793249272;4591.081783643268;4598.126355992359;4622.445306563217;4610.170169369512;4615.261558150696;4624.653151013687;4640.721556706591;4641.744704041276;4576.679632425731;4584.060267645142;4586.97706511467;4587.8623641290815;4599.954000459986;4381.912361752763;4494.348319493655;4590.0590378972565;4598.931016034762;4609.216433206363;4072.5927407259333;4078.8572399966156;4084.6323830855067;4088.3458646616696;4094.2425651254316;5555.722213889289;5557.638753481051;5561.416051314594;5565.833025009256;5570.415106413809;5358.4641535846495;5358.651687640291;5363.973180134113;5368.758405871745;5373.7581808818695;6235.033569796644;6247.843803904893;6249.312575616678;6250.968745156245;6251.593646412968;4504.09918016398;4518.1415531049;4519.389882365871;4520.208963431419;4523.389342438762;6470.38531339522;6480.384363485461;6491.545591808575;6491.93508064918;6493.70778314977;4640.69835460694;4645.953540464619;4646.883827904329;4657.534246575316;4657.813687452532;4700.730802683324;4704.670673052922;4711.740854253049;4712.50518695532;4723.078999595046;5292.2326262691695;5296.417394086648;5298.470152984671;5343.332083489564;5347.491988261109;6085.726142323606;6234.906476402857;6245.875082498324;6246.656433896089;6261.24865016201;1638.6640738648548;1655.2551351891698;1660.0371784365038;1665.6918470083074;1665.7168281392192;1047.3977462958828;1120.5853834081443;1131.1629394248198;1150.750283196349;1154.4458659843322;6005.648729035932;6084.574079814459;6093.207882975274;6094.786682466092;6095.573309868355;6413.551051426355;6415;6425.967870160713;6426.3573642635365;6429;6051.364606716319;6064.120702498113;6085.66528840918;6086.573939824259;6095.207623008981;3434.364642541138;3436.7766095203733;3438.2951494943477;3457.7233821294235;3476.28736109097;6452.225732911987;6646.302138275508;6658.633775142317;6660.900951343071;6661.134052573231;6465.030245463124;6467.579607325509;6529.575577587441;6549.803505894831;6550.836229094215;6684.030815531721;6695.866082678319;6703.966480167568;6714.630695311805;6735.730570777114;6378.74485020594;6386.521010924106;6389.840253993687;6402.90395644075;6415.454686351713;6244.562880598496;6309.4952403806665;6328.335524770017;6349.523785716182;6471.935280647322;6800;6854.074699915647;6855.897161542481;6864.622445765331;6881.277465866012;4520.547945205453;4563.338315944103;4573.108243892409;4574.7941342639;4577.8397756078375;6561.80314590563;6563.146790917151;6567.179102612174;6571.80284591463;6578.013298005338;6388;6400.967995160181;6404.775832845828;6408.1349017881985;6410.45511131559;6219.626822390671;6351.555391122577;6389.7763578274535;6398.616083035033;6402.35976402356;6269.905951410824;6286.497080233479;6298.937010630018;6306.243250809932;6358.141650877073;6412.935870641234;6422.133012043314;6425.45383642377;6428.035794630843;6428.8071357859335;6047.848803779941;6088.756449741961;6160.722767475564;6249.312575616769;6273.059041143865 05:20:01 INFO - PROCESS | 30925 | |5;yui.html;801.9518828870266;844.4595458906299;867.2195024477969;888.5690440136528;904.4618452021049;13393.263370514618;13655.317234138303;13661.726765464684;13684.247366394844;13722.656933576653;12834.358282085905;12862;12950.546730864422;13129.21224726517;13415.798763018562;916.3951791817385;927.1192367251139;933.7198840347902;934.0192797562567;935.1069728409386;922;925.2413021322518;926.0091701878993;926.9443833370019;927.184078011349;970.1268858027796;972.2562239886493;972.9416235025885;973.3964941736134;973.4889183178817;963.8746962894813;964.0455948610895;965.541367850269;965.7875267441187;965.9372140810825;711.0187940641881;712.0743034055758;712.7006657203987;713.1371041040347;713.4328209073799;12998.805017924738;13019.218846869218;13039.152455090389;13187.868121318856;13212.86787132126;12153.210041347284;12245.204061735958;12320.75358492825;12579.811302830465;12629.810552841715;10423.530941107669;10756.623518176904;10786.298890572167;10794.784104317949;11013.229073964825;3809.5238095238096;3848.634379733921;3880.9223815523815;3957.920841583181;4410.933835992462;47483.76258118687;50470.7476462619;51693.22460163101;51811;52566.21150682704;11293.491792869341;11336.376499292453;11606.593769218036;11639;11685;20180.798192018185;20290.69563956542;20343;20372.38882833488;20378.388648340573;8132;8139.064007639079;8178.918210817816;8201.589920503951;8462.957685211657;4368.737875727403;4459.620932220798;4482.372467854503;4502.482214545304;4615.5845973862515;3360.1599600099976;3404.4042292598697;3408.4205685033603;3408.5739282589675;3408.744344174197;616.1527899138684;629.7292164369273;634.3054355480741;634.6445990245477;646.8544577470126;735.5255859970289;742.784592468189;750.5084169868636;767.2519293688609;778.9143194248628;8671.869921951176;8815.955920220485;8840.734777956672;9225.630974760934;9266.490343031062;659.3637140159769;704.527966262595;704.8167476456158;725.2493669052611;732.0775822463734;4093.5497095319492;4246.893827654333;4278.871633850989;4314.223439780807;4345.847895323648;61791.691041545404;62390.376096238455;62719;65030.34969650243;66345;51834.22248666273;52123.21815172776;52793.472065279624;53071.46928530665;54426;48578.757106214245;48631;48785;52683;53050.734746326794;8976.461412315282;9130.680426185052;9154.221891139061;9182.540872956459;9402.52987350616;36210.637893620726;36270.45594316035;37243.81378093092;37559.62440375671;38434.6156538431;45488.77255613701;47312.526874730815;47865.76067119642;48009.5199048005;48788.2681759781;11537.965452579323;11654.53381864716;11702.4733886977;11800;11971.221870578385;13203.339833008118;13277.535286264934;13423.328833558478;13619.79570306466;14235.786463203267;12543.372831358578;12587.87412125867;12713.682157946125;12878.871211287767;12901.741965160832;12583.748325033264;12834;13006.219626822422;13193.60419187426;13214.537491187762;12565.93717031409;12743.362831858556;12937.417816198105;13046.152000119962;13099.952003839478;10018.098371146632;10037.44794036335;10216.387016779017;10323.896761032294;10522.894771052192;9985.650502232678;10139.898601013896;10242.436665983443;10268.948655256676;10277.177825773771 05:20:01 INFO - PROCESS | 30925 | __end_tp_report 05:20:01 INFO - PROCESS | 30925 | __start_cc_report 05:20:01 INFO - PROCESS | 30925 | _x_x_mozilla_cycle_collect,909 05:20:01 INFO - PROCESS | 30925 | __end_cc_report 05:20:01 INFO - PROCESS | 30925 | __startTimestamp1460463601358__endTimestamp 05:20:01 INFO - PROCESS | 30925 | 05:20:01 INFO - PROCESS | 30925 | ------- Summary: start ------- 05:20:01 INFO - PROCESS | 30925 | Number of tests: 6 05:20:01 INFO - PROCESS | 30925 | 05:20:01 INFO - PROCESS | 30925 | [#0] dojo.html Cycles:165 Average:5353.55 Median:5550.64 stddev:588.07 (10.6%) stddev-sans-first:566.40 05:20:01 INFO - PROCESS | 30925 | Values: 3256.5 3312.1 3341.2 3347.7 3382.3 5356.2 5363.8 5364.0 5383.2 5392.2 5338.6 5346.0 5362.2 5372.9 5376.9 4803.7 4908.6 4923.6 4939.0 4981.5 4807.0 4871.6 4956.6 4987.4 5064.4 4977.8 5006.5 5015.3 5016.2 5034.3 4750.5 4940.3 4973.4 4991.3 5009.5 4813.1 4873.5 4874.1 4877.5 4914.5 5141.0 5149.9 5157.5 5166.1 5183.9 5687.8 5716.8 5720.0 5724.2 5742.4 5689.3 5708.8 5734.9 5739.6 5763.2 5334.4 5336.9 5337.3 5341.9 5342.1 5754.9 5781.4 5791.6 5854.9 5902.1 5639.8 5641.6 5650.7 5651.4 5654.2 5709.3 5747.4 5754.1 5767.1 5772.7 5677.0 5713.3 5763.5 5857.5 5871.4 5702.9 5712.5 5719.7 5720.1 5724.4 4303.6 4324.5 4334.5 4337.4 4360.0 3835.0 3921.2 3946.5 3961.5 3974.9 5478.7 5512.4 5517.3 5518.6 5541.4 5703.9 5806.5 5809.7 5811.2 5818.3 5397.9 5460.7 5474.6 5495.6 5511.1 4915.6 4928.8 4934.6 4938.7 4964.4 5936.9 5940.3 5946.1 5949.4 6051.1 5793.5 5794.0 5796.2 5804.2 5807.6 6037.3 6054.3 6054.4 6057.4 6061.5 5453.0 5715.7 5732.4 5733.9 5781.0 5785.0 5792.4 5795.9 5799.7 5816.3 5634.0 5659.7 5663.7 5666.6 5668.1 5465.9 5643.2 5648.7 5747.7 5773.6 5500.1 5509.8 5550.6 5550.9 5573.6 5628.3 5657.1 5668.3 5674.9 5678.7 5383.7 5465.6 5524.5 5592.6 5616.3 05:20:01 INFO - PROCESS | 30925 | 05:20:01 INFO - PROCESS | 30925 | [#1] ext.html Cycles:180 Average:49524.55 Median:22411.98 stddev:85241.28 (380.3%) stddev-sans-first:85401.00 05:20:01 INFO - PROCESS | 30925 | Values: 522.8 525.4 535.1 557.6 573.1 39686.4 40747.8 40884.0 40920.2 40944.4 43947.8 44212.0 44257.3 44601.6 44625.6 8976.6 9184.5 9189.7 9191.6 9194.1 8932.4 9078.4 9085.7 9094.9 9100.9 9295.4 9371.3 9384.5 9385.2 9388.9 9256.5 9317.8 9332.0 9338.2 9346.0 9174.6 9291.9 9299.8 9300.8 9319.0 44450.3 44892.3 44999.6 45000.8 45053.3 1813.9 3574.5 3923.5 3924.7 4022.5 33525.0 33532.7 33598.0 33918.7 34728.3 3990.2 4001.3 4019.7 4076.2 4092.9 300021.0 301060.0 301201.0 303537.0 303742.0 46129.5 47059.8 60547.4 60740.0 60807.7 48860.8 48969.0 49165.8 49195.3 49232.5 16950.9 17233.7 17257.4 17262.8 17265.5 12269.9 12322.1 12323.0 12357.8 12363.9 15719.0 15882.3 15887.9 15895.1 15942.2 5677.4 5731.0 5756.5 5820.0 5875.6 926.7 989.8 1031.8 1053.6 1112.0 28698.6 28703.4 28767.9 29412.3 29759.0 986.7 1082.4 1106.5 1131.6 1223.7 16235.4 16236.1 16316.5 16354.3 16910.2 395534.0 410522.0 411391.0 412087.0 412107.0 62063.4 62344.4 62593.7 62640.0 62705.7 1300.1 1339.1 1404.5 1414.7 1433.8 28234.0 29076.3 29484.4 29948.0 30379.4 44032.8 44811.6 44885.8 44898.6 44899.6 216473.0 246549.0 246781.0 246898.0 247289.0 29651.0 34335.7 34934.3 35482.5 35694.6 52517.5 52669.7 52915.7 53083.2 54276.0 40509.4 40696.4 40948.4 41014.6 42150.2 39717.2 40370.8 40606.8 41086.2 41199.6 39581.4 39966.6 40656.8 41072.8 41275.0 34129.0 35682.3 36088.0 36577.5 36688.1 27647.4 27880.7 27903.7 27977.4 28301.3 05:20:01 INFO - PROCESS | 30925 | 05:20:01 INFO - PROCESS | 30925 | [#2] jquery.html Cycles:180 Average:25020.63 Median:34428.48 stddev:65084.20 (189.0%) stddev-sans-first:65240.43 05:20:01 INFO - PROCESS | 30925 | Values: 357.3 357.8 364.3 377.4 379.3 17343.8 18058.6 19652.4 19657.2 19691.1 17754.1 18561.7 18664.7 18724.9 18726.2 5523.3 5758.4 5772.4 5783.7 5784.5 4235.4 5614.4 5968.8 6237.6 6281.1 6118.8 6146.6 6222.0 6227.4 6238.3 5835.4 5946.9 5964.7 5966.6 5967.1 3845.9 5242.5 5296.3 5471.2 5484.7 21706.7 21728.1 21744.6 22163.2 22225.4 2463.9 2500.4 2515.2 2515.8 2534.5 13410.5 13727.6 13750.2 13864.9 13940.9 1893.3 1918.6 1924.7 2015.5 2021.6 66494.0 68949.3 69439.7 69845.7 71126.6 9620.6 9697.8 9879.2 9939.5 10000.3 13484.9 13544.2 13557.1 13560.1 13579.5 7598.2 7639.8 7652.2 7660.2 7697.2 7724.8 7744.9 7773.7 7837.1 7873.9 4301.2 4367.9 4404.1 4407.8 4417.6 1800.5 1832.2 1842.9 1898.7 1932.3 955.3 956.9 1015.1 1019.4 1069.1 17009.9 17052.3 17156.5 17310.5 17787.7 982.6 995.1 1023.5 1025.1 1047.7 9987.8 10069.3 10120.3 10135.2 10167.8 388976.0 395958.0 396712.0 397168.0 397862.0 74088.0 76658.0 77558.2 78050.0 78330.0 990.7 1009.3 1012.6 1015.0 1046.4 15482.8 15484.8 15535.5 15537.1 15685.8 33256.3 33854.7 35002.3 35511.5 35763.1 48324.0 49229.3 49291.3 49899.5 52312.7 7925.8 8145.5 8206.4 8332.1 8642.9 9885.8 13594.9 13615.2 13787.6 13854.4 11823.1 11984.6 12055.2 12104.9 12208.8 11807.3 12023.5 12111.4 12314.6 12395.9 11145.2 11596.8 11830.3 11970.2 12384.0 8561.4 8602.5 8661.5 8706.9 8737.1 11071.8 11435.5 11694.3 11776.7 11930.8 05:20:01 INFO - PROCESS | 30925 | 05:20:01 INFO - PROCESS | 30925 | [#3] mootools.html Cycles:180 Average:5899.74 Median:2831.33 stddev:3169.49 (111.9%) stddev-sans-first:3160.61 05:20:01 INFO - PROCESS | 30925 | Values: 1433.8 1525.6 1530.2 1744.5 1876.5 8072.0 8405.5 8409.3 8411.0 8461.7 8257.5 8375.7 8379.0 8391.1 8395.0 2166.8 2213.7 2402.4 2414.3 2445.5 2425.5 2433.6 2437.0 2439.8 2440.1 2317.9 2353.5 2365.3 2370.0 2372.8 2136.4 2320.8 2400.4 2431.7 2439.9 2305.7 2349.3 2350.8 2353.8 2358.6 8183.7 8227.2 8238.8 8244.1 8259.0 4953.2 5066.6 5073.5 5075.2 5077.3 3041.7 3167.3 3189.4 3193.6 3200.6 1043.9 1043.9 1056.2 1063.4 1078.3 11928.6 12044.6 12048.3 12064.8 12069.8 4296.4 4485.8 4633.6 4684.2 4684.8 10153.0 10153.6 10168.8 10192.8 10194.6 5146.0 5195.3 5199.6 5201.3 5208.3 4088.2 4220.5 4700.5 4712.3 4762.1 3887.5 3925.3 3927.7 3943.9 3992.3 1237.2 1244.2 1255.4 1278.5 1293.6 1401.5 1412.7 1424.8 1425.4 1447.3 8154.6 8203.5 8229.2 8243.1 8245.2 516.7 534.6 535.7 536.8 544.5 6261.7 6263.7 6267.3 6281.4 6323.1 10090.6 10359.2 10573.6 10577.8 10592.6 10106.2 10300.9 10360.7 10365.5 10459.4 8071.5 8168.7 8203.3 8204.3 8235.6 7857.5 7933.4 7940.5 7943.6 8023.1 9258.1 9296.3 9418.5 9512.7 9541.2 9504.1 9553.9 9772.5 9833.8 9848.5 6637.8 6799.5 7142.3 7347.6 7446.1 7773.7 7804.1 7808.4 7815.3 7828.8 7080.2 7198.7 7227.1 7314.9 7334.3 6856.1 6924.4 6947.2 6977.8 7039.2 7264.4 7420.8 7443.4 7443.9 7511.4 6974.8 6989.1 6996.0 7009.3 7013.1 7117.4 7119.8 7241.5 7265.0 7265.1 05:20:01 INFO - PROCESS | 30925 | 05:20:01 INFO - PROCESS | 30925 | [#4] prototype.html Cycles:180 Average:5295.42 Median:6026.75 stddev:1562.99 (25.9%) stddev-sans-first:1522.56 05:20:01 INFO - PROCESS | 30925 | Values: 344.8 347.1 354.8 357.9 363.6 5895.4 5922.1 5951.6 5957.9 5974.3 5885.8 5886.5 5889.8 5903.3 5910.2 4407.2 4522.1 4591.1 4598.1 4622.4 4610.2 4615.3 4624.7 4640.7 4641.7 4576.7 4584.1 4587.0 4587.9 4600.0 4381.9 4494.3 4590.1 4598.9 4609.2 4072.6 4078.9 4084.6 4088.3 4094.2 5555.7 5557.6 5561.4 5565.8 5570.4 5358.5 5358.7 5364.0 5368.8 5373.8 6235.0 6247.8 6249.3 6251.0 6251.6 4504.1 4518.1 4519.4 4520.2 4523.4 6470.4 6480.4 6491.5 6491.9 6493.7 4640.7 4646.0 4646.9 4657.5 4657.8 4700.7 4704.7 4711.7 4712.5 4723.1 5292.2 5296.4 5298.5 5343.3 5347.5 6085.7 6234.9 6245.9 6246.7 6261.2 1638.7 1655.3 1660.0 1665.7 1665.7 1047.4 1120.6 1131.2 1150.8 1154.4 6005.6 6084.6 6093.2 6094.8 6095.6 6413.6 6415.0 6426.0 6426.4 6429.0 6051.4 6064.1 6085.7 6086.6 6095.2 3434.4 3436.8 3438.3 3457.7 3476.3 6452.2 6646.3 6658.6 6660.9 6661.1 6465.0 6467.6 6529.6 6549.8 6550.8 6684.0 6695.9 6704.0 6714.6 6735.7 6378.7 6386.5 6389.8 6402.9 6415.5 6244.6 6309.5 6328.3 6349.5 6471.9 6800.0 6854.1 6855.9 6864.6 6881.3 4520.5 4563.3 4573.1 4574.8 4577.8 6561.8 6563.1 6567.2 6571.8 6578.0 6388.0 6401.0 6404.8 6408.1 6410.5 6219.6 6351.6 6389.8 6398.6 6402.4 6269.9 6286.5 6298.9 6306.2 6358.1 6412.9 6422.1 6425.5 6428.0 6428.8 6047.8 6088.8 6160.7 6249.3 6273.1 05:20:01 INFO - PROCESS | 30925 | 05:20:01 INFO - PROCESS | 30925 | [#5] yui.html Cycles:180 Average:14755.82 Median:4471.00 stddev:17078.74 (382.0%) stddev-sans-first:17094.50 05:20:01 INFO - PROCESS | 30925 | Values: 802.0 844.5 867.2 888.6 904.5 13393.3 13655.3 13661.7 13684.2 13722.7 12834.4 12862.0 12950.5 13129.2 13415.8 916.4 927.1 933.7 934.0 935.1 922.0 925.2 926.0 926.9 927.2 970.1 972.3 972.9 973.4 973.5 963.9 964.0 965.5 965.8 965.9 711.0 712.1 712.7 713.1 713.4 12998.8 13019.2 13039.2 13187.9 13212.9 12153.2 12245.2 12320.8 12579.8 12629.8 10423.5 10756.6 10786.3 10794.8 11013.2 3809.5 3848.6 3880.9 3957.9 4410.9 47483.8 50470.7 51693.2 51811.0 52566.2 11293.5 11336.4 11606.6 11639.0 11685.0 20180.8 20290.7 20343.0 20372.4 20378.4 8132.0 8139.1 8178.9 8201.6 8463.0 4368.7 4459.6 4482.4 4502.5 4615.6 3360.2 3404.4 3408.4 3408.6 3408.7 616.2 629.7 634.3 634.6 646.9 735.5 742.8 750.5 767.3 778.9 8671.9 8816.0 8840.7 9225.6 9266.5 659.4 704.5 704.8 725.2 732.1 4093.5 4246.9 4278.9 4314.2 4345.8 61791.7 62390.4 62719.0 65030.3 66345.0 51834.2 52123.2 52793.5 53071.5 54426.0 48578.8 48631.0 48785.0 52683.0 53050.7 8976.5 9130.7 9154.2 9182.5 9402.5 36210.6 36270.5 37243.8 37559.6 38434.6 45488.8 47312.5 47865.8 48009.5 48788.3 11538.0 11654.5 11702.5 11800.0 11971.2 13203.3 13277.5 13423.3 13619.8 14235.8 12543.4 12587.9 12713.7 12878.9 12901.7 12583.7 12834.0 13006.2 13193.6 13214.5 12565.9 12743.4 12937.4 13046.2 13100.0 10018.1 10037.4 10216.4 10323.9 10522.9 9985.7 10139.9 10242.4 10268.9 10277.2 05:20:01 INFO - PROCESS | 30925 | -------- Summary: end -------- 05:20:01 INFO - PROCESS | 30925 | 05:20:01 INFO - TEST-INFO | 30925: exit 0 05:20:02 INFO - TEST-OK | dromaeo_css | took 1111961ms 05:20:02 INFO - TEST-START | kraken 05:20:02 INFO - operating with platform_type : linux_ 05:20:02 INFO - Initialising browser for kraken test... 05:20:02 INFO - TEST-INFO | started process 31124 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo8Kdoy/profile http://localhost:32945/getInfo.html) 05:20:06 INFO - PROCESS | 31124 | __metrics Screen width/height:1600/1200 05:20:06 INFO - PROCESS | 31124 | colorDepth:24 05:20:06 INFO - PROCESS | 31124 | Browser inner width/height: 1024/697 05:20:06 INFO - PROCESS | 31124 | __metrics 05:20:07 INFO - PROCESS | 31124 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:20:07 INFO - TEST-INFO | 31124: exit 0 05:20:07 INFO - Browser initialized. 05:20:07 INFO - Running cycle 1/1 for kraken test... 05:20:07 INFO - TEST-INFO | started process 31215 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpo8Kdoy/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:19 INFO - PROCESS | 31215 | RSS: Main: 142278656 05:20:19 INFO - PROCESS | 31215 | 05:20:22 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32945/tests/kraken/driver.html?testName=audio-beat-detection) 05:20:22 INFO - PROCESS | 31215 | RSS: Main: 177528832 05:20:22 INFO - PROCESS | 31215 | 05:20:25 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32945/tests/kraken/driver.html?testName=audio-dft) 05:20:26 INFO - PROCESS | 31215 | RSS: Main: 175529984 05:20:26 INFO - PROCESS | 31215 | 05:20:28 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32945/tests/kraken/driver.html?testName=audio-fft) 05:20:29 INFO - PROCESS | 31215 | RSS: Main: 172818432 05:20:29 INFO - PROCESS | 31215 | 05:20:31 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32945/tests/kraken/driver.html?testName=audio-oscillator) 05:20:32 INFO - PROCESS | 31215 | RSS: Main: 173355008 05:20:32 INFO - PROCESS | 31215 | 05:20:34 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32945/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:20:34 INFO - PROCESS | 31215 | RSS: Main: 171892736 05:20:34 INFO - PROCESS | 31215 | 05:20:37 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32945/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:38 INFO - PROCESS | 31215 | RSS: Main: 171618304 05:20:38 INFO - PROCESS | 31215 | 05:20:41 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32945/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:42 INFO - PROCESS | 31215 | RSS: Main: 172003328 05:20:42 INFO - PROCESS | 31215 | 05:20:45 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32945/tests/kraken/driver.html?testName=json-parse-financial) 05:20:45 INFO - PROCESS | 31215 | RSS: Main: 172097536 05:20:45 INFO - PROCESS | 31215 | 05:20:47 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32945/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:47 INFO - PROCESS | 31215 | RSS: Main: 175915008 05:20:47 INFO - PROCESS | 31215 | 05:20:49 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32945/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:50 INFO - PROCESS | 31215 | RSS: Main: 174387200 05:20:50 INFO - PROCESS | 31215 | 05:20:52 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32945/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:52 INFO - PROCESS | 31215 | RSS: Main: 180285440 05:20:52 INFO - PROCESS | 31215 | 05:20:55 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:20:55 INFO - PROCESS | 31215 | RSS: Main: 188416000 05:20:55 INFO - PROCESS | 31215 | 05:20:58 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:20:58 INFO - PROCESS | 31215 | RSS: Main: 187547648 05:20:58 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | Cycle 1(1): loaded http://localhost:32945/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32945/tests/kraken/driver.html?testName=ai-astar) 05:21:00 INFO - PROCESS | 31215 | RSS: Main: 249794560 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | __start_tp_report 05:21:00 INFO - PROCESS | 31215 | _x_x_mozilla_page_load 05:21:00 INFO - PROCESS | 31215 | _x_x_mozilla_page_load_details 05:21:00 INFO - PROCESS | 31215 | |i|pagename|runs| 05:21:00 INFO - PROCESS | 31215 | |0;ai-astar;111;109;104;109;110;110;98;108;109;109 05:21:00 INFO - PROCESS | 31215 | |1;audio-beat-detection;162;125;152;175;126;159;165;133;189;133 05:21:00 INFO - PROCESS | 31215 | |2;audio-dft;162;160;161;161;160;160;159;165;161;161 05:21:00 INFO - PROCESS | 31215 | |3;audio-fft;75;73;76;166;76;74;76;77;163;76 05:21:00 INFO - PROCESS | 31215 | |4;audio-oscillator;94;92;147;94;94;92;144;93;93;141 05:21:00 INFO - PROCESS | 31215 | |5;imaging-gaussian-blur;117;117;117;117;117;116;117;117;117;117 05:21:00 INFO - PROCESS | 31215 | |6;imaging-darkroom;146;145;146;146;146;147;146;146;146;146 05:21:00 INFO - PROCESS | 31215 | |7;imaging-desaturate;96;95;96;97;95;96;96;96;96;96 05:21:00 INFO - PROCESS | 31215 | |8;json-parse-financial;55;55;55;55;55;55;55;64;53;53 05:21:00 INFO - PROCESS | 31215 | |9;json-stringify-tinderbox;64;65;65;64;65;65;65;68;65;64 05:21:00 INFO - PROCESS | 31215 | |10;stanford-crypto-aes;77;79;78;78;77;84;77;86;78;79 05:21:00 INFO - PROCESS | 31215 | |11;stanford-crypto-ccm;113;120;110;111;119;111;119;111;110;110 05:21:00 INFO - PROCESS | 31215 | |12;stanford-crypto-pbkdf2;155;134;142;139;153;134;142;140;152;141 05:21:00 INFO - PROCESS | 31215 | |13;stanford-crypto-sha256-iterative;66;67;69;65;65;66;66;65;64;66 05:21:00 INFO - PROCESS | 31215 | __end_tp_report 05:21:00 INFO - PROCESS | 31215 | __start_cc_report 05:21:00 INFO - PROCESS | 31215 | _x_x_mozilla_cycle_collect,1081 05:21:00 INFO - PROCESS | 31215 | __end_cc_report 05:21:00 INFO - PROCESS | 31215 | __startTimestamp1460463660727__endTimestamp 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | ------- Summary: start ------- 05:21:00 INFO - PROCESS | 31215 | Number of tests: 14 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#0] ai-astar Cycles:10 Average:107.70 Median:109.50 stddev:3.89 (3.6%) stddev-sans-first:3.94 05:21:00 INFO - PROCESS | 31215 | Values: 111.0 109.0 104.0 109.0 110.0 110.0 98.0 108.0 109.0 109.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:160.50 stddev:21.97 (13.7%) stddev-sans-first:22.99 05:21:00 INFO - PROCESS | 31215 | Values: 162.0 125.0 152.0 175.0 126.0 159.0 165.0 133.0 189.0 133.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.63 (1.0%) stddev-sans-first:1.69 05:21:00 INFO - PROCESS | 31215 | Values: 162.0 160.0 161.0 161.0 160.0 160.0 159.0 165.0 161.0 161.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#3] audio-fft Cycles:10 Average:93.20 Median:76.00 stddev:37.60 (49.5%) stddev-sans-first:39.30 05:21:00 INFO - PROCESS | 31215 | Values: 75.0 73.0 76.0 166.0 76.0 74.0 76.0 77.0 163.0 76.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#4] audio-oscillator Cycles:10 Average:108.40 Median:93.00 stddev:24.62 (26.5%) stddev-sans-first:25.55 05:21:00 INFO - PROCESS | 31215 | Values: 94.0 92.0 147.0 94.0 94.0 92.0 144.0 93.0 93.0 141.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 05:21:00 INFO - PROCESS | 31215 | Values: 117.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 05:21:00 INFO - PROCESS | 31215 | Values: 146.0 145.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 05:21:00 INFO - PROCESS | 31215 | Values: 96.0 95.0 96.0 97.0 95.0 96.0 96.0 96.0 96.0 96.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:55.00 stddev:3.10 (5.6%) stddev-sans-first:3.28 05:21:00 INFO - PROCESS | 31215 | Values: 55.0 55.0 55.0 55.0 55.0 55.0 55.0 64.0 53.0 53.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.15 (1.8%) stddev-sans-first:1.17 05:21:00 INFO - PROCESS | 31215 | Values: 64.0 65.0 65.0 64.0 65.0 65.0 65.0 68.0 65.0 64.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#10] stanford-crypto-aes Cycles:10 Average:79.30 Median:78.50 stddev:3.13 (4.0%) stddev-sans-first:3.21 05:21:00 INFO - PROCESS | 31215 | Values: 77.0 79.0 78.0 78.0 77.0 84.0 77.0 86.0 78.0 79.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#11] stanford-crypto-ccm Cycles:10 Average:113.40 Median:112.00 stddev:4.20 (3.7%) stddev-sans-first:4.45 05:21:00 INFO - PROCESS | 31215 | Values: 113.0 120.0 110.0 111.0 119.0 111.0 119.0 111.0 110.0 110.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.20 Median:142.00 stddev:7.58 (5.3%) stddev-sans-first:6.74 05:21:00 INFO - PROCESS | 31215 | Values: 155.0 134.0 142.0 139.0 153.0 134.0 142.0 140.0 152.0 141.0 05:21:00 INFO - PROCESS | 31215 | 05:21:00 INFO - PROCESS | 31215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.37 (2.1%) stddev-sans-first:1.45 05:21:00 INFO - PROCESS | 31215 | Values: 66.0 67.0 69.0 65.0 65.0 66.0 66.0 65.0 64.0 66.0 05:21:00 INFO - PROCESS | 31215 | -------- Summary: end -------- 05:21:00 INFO - PROCESS | 31215 | 05:21:01 INFO - TEST-INFO | 31215: exit 0 05:21:01 INFO - TEST-OK | kraken | took 59640ms 05:21:01 INFO - SUITE-END | took 1171s 05:21:01 INFO - Completed test suite (00:19:31) 05:21:01 INFO - javascript benchmark 05:21:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3256.527803468497, 3312.0726196664914, 3341.181410554413, 3347.6819702128305, 3382.272811345561, 5356.169793681981, 5363.785448582052, 5363.973180134099, 5383.192521121834, 5392.2181283713835, 5338.599605029619, 5346.0, 5362.195670649405, 5372.865678358043, 5376.946230537694, 4803.711777293356, 4908.558229759321, 4923.556879880819, 4938.950610493885, 4981.476944920785, 4807.038592281558, 4871.5615594596475, 4956.603471722272, 4987.376577927759, 5064.366954130734, 4977.751112444382, 5006.474320196364, 5015.297858299841, 5016.247562865563, 5034.295198672189, 4750.548697873696, 4940.3330550375595, 4973.353464049686, 4991.32617096691, 5009.499050094998, 4813.085513752376, 4873.488283730193, 4874.073925954093, 4877.463479017305, 4914.4839791821705, 5141.048905952411, 5149.922751158736, 5157.535821776059, 5166.095933211711, 5183.948160518385, 5687.829365119053, 5716.799912003102, 5720.027595308808, 5724.227229324029, 5742.368339482654, 5689.260396148516, 5708.828735137952, 5734.856628584319, 5739.598228124033, 5763.221965034709, 5334.413214546396, 5336.946630533684, 5337.306150200527, 5341.946580534183, 5342.1452567589, 5754.942450575524, 5781.392953739797, 5791.594588378857, 5854.912176317359, 5902.085176797603, 5639.774409023676, 5641.633293835887, 5650.660960342392, 5651.406602306781, 5654.151877218368, 5709.34342550612, 5747.3677895431465, 5754.0505816540635, 5767.077267637158, 5772.740226689809, 5676.971615141898, 5713.2572765541045, 5763.538916886639, 5857.472827445466, 5871.4128587141795, 5702.857428564319, 5712.485876271156, 5719.656820590778, 5720.08478643415, 5724.427557244326, 4303.569643035671, 4324.545922678073, 4334.45819272591, 4337.414449049338, 4360.0, 3834.9616503835164, 3921.2353591049473, 3946.4869566956113, 3961.544422391404, 3974.9205015900097, 5478.671279723229, 5512.366077901012, 5517.282753242052, 5518.613697041249, 5541.418151094077, 5703.885922281531, 5806.506446951972, 5809.7095145242565, 5811.186433899257, 5818.301803783488, 5397.865053373697, 5460.6996615186545, 5474.616776825584, 5495.6153069285565, 5511.118221084687, 4915.557599816034, 4928.827491037868, 4934.55588996992, 4938.703677779345, 4964.379452568429, 5936.851578710567, 5940.34656187819, 5946.108083787466, 5949.405059494103, 6051.122587224828, 5793.478586927196, 5794.0439827428, 5796.21751063601, 5804.187413762161, 5807.622504537191, 6037.335893051673, 6054.303755068224, 6054.424829641177, 6057.394260573908, 6061.454469097803, 5452.991196628636, 5715.657060576379, 5732.426757324234, 5733.881893030819, 5780.959427303126, 5785.016547187072, 5792.3917988612275, 5795.913061304, 5799.710014499343, 5816.331121921034, 5634.0, 5659.688717120598, 5663.716814159358, 5666.575006874418, 5668.149777533238, 5465.918011229915, 5643.209950607001, 5648.689322087324, 5747.7413516391025, 5773.624714393551, 5500.092484739973, 5509.834704958857, 5550.639208451437, 5550.916736248879, 5573.637713548606, 5628.324601047901, 5657.12314591239, 5668.319801623831, 5674.858128546819, 5678.6876721779045, 5383.703896285742, 5465.562754979672, 5524.475174858382, 5592.636478628876, 5616.297962754656], "unit": "score", "name": "dojo.html", "value": 5316.230635446357}, {"lowerIsBetter": false, "replicates": [522.8039485193055, 525.3931708876247, 535.1117145538406, 557.6208178438662, 573.1088157914446, 39686.40470392947, 40747.796261018724, 40883.97790055246, 40920.18159636809, 40944.38583421244, 43947.78026109873, 44212.0, 44257.33613995793, 44601.553984460144, 44625.553744462544, 8976.640934362635, 9184.540772961358, 9189.678361257358, 9191.586378612945, 9194.12655797698, 8932.374733768638, 9078.409903356294, 9085.682001129962, 9094.909050909506, 9100.863487047667, 9295.442273463614, 9371.34400591959, 9384.483853388061, 9385.155336019758, 9388.906110938871, 9256.537173141349, 9317.767055823591, 9332.0, 9338.159565639091, 9346.018668039895, 9174.587143578556, 9291.907080929172, 9299.76750581234, 9300.813983720287, 9319.021502742182, 44450.33324500135, 44892.3266151008, 44999.55000450019, 45000.77499612514, 45053.32420013702, 1813.8820976636475, 3574.5174401455993, 3923.5487918889407, 3924.6664033556895, 4022.4971878515184, 33525.0, 33532.664673353196, 33598.0, 33918.6608133918, 34728.30543389143, 3990.182012687392, 4001.279769641463, 4019.6985226107868, 4076.164386300801, 4092.856750013765, 300021.0, 301060.0, 301201.0, 303537.0, 303741.9999999978, 46129.538704612525, 47059.76470117696, 60547.39452605505, 60740.0, 60807.69596151991, 48860.75569622129, 48969.0, 49165.75417122892, 49195.262071068966, 49232.50767492351, 16950.915245423694, 17233.741493877602, 17257.3959911405, 17262.82737172612, 17265.482035538953, 12269.938650306869, 12322.075844311712, 12323.0, 12357.814632780515, 12363.93818030904, 15719.0, 15882.285297161656, 15887.920560397124, 15895.125768082635, 15942.20288985546, 5677.403872593401, 5731.014017804537, 5756.539476841926, 5819.970900145557, 5875.6474611523445, 926.7219834049758, 989.8023391696129, 1031.8443343455378, 1053.5733028123623, 1112.0158659586164, 28698.569521457193, 28703.42593148125, 28767.856160719482, 29412.264693382836, 29759.0, 986.7483791633088, 1082.3992684060422, 1106.4578356605205, 1131.6191509373043, 1223.6879595703217, 16235.431759888348, 16236.1070141141, 16316.510504684878, 16354.345826167058, 16910.239039243264, 395534.0, 410522.0, 411391.0, 412087.0, 412107.0, 62063.37936620666, 62344.37655623476, 62593.68703156455, 62640.0, 62705.68647156735, 1300.1419063418098, 1339.1295657822493, 1404.515442172449, 1414.6684557866076, 1433.813604231464, 28234.0, 29076.27309317284, 29484.410311793214, 29948.0, 30379.392412152076, 44032.77983610061, 44811.55188448204, 44885.77557112324, 44898.551014490746, 44899.551004490844, 216473.0, 246549.0, 246781.0, 246898.0, 247289.0, 29650.962216322325, 34335.65664343325, 34934.30131397307, 35482.46776298306, 35694.64305356913, 52517.474825252786, 52669.736651316496, 52915.73542132265, 53083.20375194298, 54276.0, 40509.39235911405, 40696.3895541573, 40948.38577421282, 41014.589854101076, 42150.15699685928, 39717.2056558873, 40370.79814600908, 40606.79696601498, 41086.178276434905, 41199.58800412077, 39581.40627890641, 39966.600333996284, 40656.79671601623, 41072.79463602663, 41275.0, 34129.0, 35682.28635427329, 36088.0, 36577.45133823048, 36688.08279793026, 27647.44705105927, 27880.721192787812, 27903.720962790114, 27977.44045119127, 28301.292467688472], "unit": "score", "name": "ext.html", "value": 19213.697844575774}, {"lowerIsBetter": false, "replicates": [357.26581874248427, 357.8103605089302, 364.28599944109544, 377.42631200575124, 379.25287184247026, 17343.82656173438, 18058.638827223465, 19652.410427687155, 19657.213711451524, 19691.113899874523, 17754.112294385293, 18561.721574176398, 18664.720029199572, 18724.876507409565, 18726.157322920466, 5523.309586301722, 5758.395368486312, 5772.393898640646, 5783.652980821164, 5784.508316793078, 4235.449391579105, 5614.382417934024, 5968.79109231177, 6237.563370564062, 6281.120643109968, 6118.755249790003, 6146.6312021278645, 6221.9688901555655, 6227.3772622737815, 6238.344973777756, 5835.387284335147, 5946.940530594682, 5964.7315870785915, 5966.642001479925, 5967.075103358986, 3845.8653947111998, 5242.528172464458, 5296.25852380667, 5471.206675032098, 5484.725763711798, 21706.674399884014, 21728.13087476499, 21744.565108697738, 22163.224287150035, 22225.44436389087, 2463.8768061596847, 2500.374906273432, 2515.1699939020077, 2515.76100270474, 2534.4931013797313, 13410.530631427951, 13727.588172354845, 13750.174989500561, 13864.930675346559, 13940.860591394057, 1893.280553389717, 1918.6162767446426, 1924.70167124096, 2015.4961259685078, 2021.6057868715607, 66494.0, 68949.31050689479, 69439.65280173566, 69845.65077174582, 71126.64436677784, 9620.567074481665, 9697.806043879084, 9879.209663226924, 9939.50302484873, 10000.2999790014, 13484.865151348557, 13544.187348759106, 13557.118787278796, 13560.118592291667, 13579.45682172702, 7598.164201937782, 7639.809004774814, 7652.196519365387, 7660.1573826879, 7697.230276972258, 7724.7682569523, 7744.883826742604, 7773.727919522789, 7837.137914829478, 7873.881891771628, 4301.161273551627, 4367.868963931087, 4404.141192467502, 4407.801648925806, 4417.580329868657, 1800.522861441719, 1832.2145313223127, 1842.912681517884, 1898.7057006164066, 1932.285054529805, 955.2501286490211, 956.9425834449955, 1015.1117771949545, 1019.3527110285022, 1069.0859315285475, 17009.91495042517, 17052.317907283817, 17156.485305440856, 17310.480685579452, 17787.73318400225, 982.5676702250987, 995.1392045880406, 1023.518946095334, 1025.1491262252312, 1047.6961681112543, 9987.80024399508, 10069.345492542961, 10120.342177758423, 10135.189184865194, 10167.762131426087, 388976.0, 395958.0, 396712.0, 397168.0, 397862.0, 74088.0, 76658.0, 77558.22441775622, 78050.0, 78330.0, 990.6780296403698, 1009.3035805294323, 1012.5696578954063, 1015.0255754475786, 1046.4401545173296, 15482.767758483857, 15484.845151548341, 15535.533933981998, 15537.145456999973, 15685.764713529534, 33256.33487330288, 33854.66145338515, 35002.29995400129, 35511.46732799062, 35763.10592235111, 48324.0, 49229.261561075895, 49291.26063109128, 49899.501004989484, 52312.738436307576, 7925.762227133196, 8145.51126932386, 8206.384521160817, 8332.125126861592, 8642.870356944777, 9885.802283954425, 13594.86405135936, 13615.183089014294, 13787.586372408843, 13854.376553054935, 11823.054155667698, 11984.58053968107, 12055.21641093326, 12104.878951210376, 12208.816867746813, 11807.291562505934, 12023.4589443477, 12111.394430278628, 12314.630561083182, 12395.876041239471, 11145.164112691742, 11596.76806463849, 11830.349330786888, 11970.162088653711, 12384.0, 8561.44350617208, 8602.483850968962, 8661.480311181349, 8706.912930870863, 8737.082606326245, 11071.833922491009, 11435.485403156712, 11694.2983420995, 11776.70558236051, 11930.76138477243], "unit": "score", "name": "jquery.html", "value": 8880.466200919638}, {"lowerIsBetter": false, "replicates": [1433.8279406471224, 1525.5575882993928, 1530.18899983009, 1744.4592176425308, 1876.5190571489895, 8072.0, 8405.495670259788, 8409.327253819694, 8410.95794521028, 8461.746147615582, 8257.504549727006, 8375.706850260241, 8378.958105209465, 8391.076981532027, 8395.0, 2166.8483206175574, 2213.7454192767796, 2402.4474370894704, 2414.2877851033986, 2445.510897820434, 2425.454272788626, 2433.610622300432, 2437.049550675229, 2439.829211955164, 2440.1459489178824, 2317.9420514487188, 2353.470469144446, 2365.254944692425, 2370.004598068815, 2372.7508611595795, 2136.4445244236454, 2320.8375413721046, 2400.3999000249937, 2431.6960379952507, 2439.865807380593, 2305.7348404933314, 2349.259983105316, 2350.764923507653, 2353.8469999450153, 2358.646203069536, 8183.71357002502, 8227.177282271785, 8238.83522329556, 8244.093149753522, 8259.0, 4953.182724850395, 5066.594672426197, 5073.518015788494, 5075.187969924795, 5077.314562534048, 3041.65021022583, 3167.255694911694, 3189.378071276079, 3193.6327322357993, 3200.567923330344, 1043.88517263101, 1043.88517263101, 1056.2395075545671, 1063.3619828103153, 1078.3152698036724, 11928.58249961256, 12044.578439754567, 12048.277103373737, 12064.819027714591, 12069.758604827854, 4296.37702533131, 4485.798139083749, 4633.606143477775, 4684.180268453007, 4684.789184486706, 10153.0, 10153.64462243818, 10168.847467287997, 10192.847107293397, 10194.643187488551, 5146.0, 5195.272661827347, 5199.558037566773, 5201.323827902348, 5208.296879921162, 4088.1823635273063, 4220.451341325608, 4700.459447163552, 4712.293156026555, 4762.071396077731, 3887.494625698641, 3925.293447179478, 3927.7446965947124, 3943.901402464904, 3992.341263691458, 1237.1834589171103, 1244.2285782814713, 1255.3974092435499, 1278.520554791953, 1293.5989843148654, 1401.5304872867703, 1412.7033323002079, 1424.7862820576788, 1425.415579612354, 1447.269129089824, 8154.633041513146, 8203.548804815793, 8229.177082291722, 8243.093259741423, 8245.175482451827, 516.654661069579, 534.6017217173231, 535.7428434351533, 536.8469986053956, 544.4528249109619, 6261.655608941552, 6263.749450022039, 6267.310595834455, 6281.371862813773, 6323.114763933053, 10090.646827361006, 10359.171266298677, 10573.62992295266, 10577.788444231226, 10592.576296948037, 10106.242031847642, 10300.896991029993, 10360.689179324632, 10365.533550990223, 10459.424731639681, 8071.5157090573575, 8168.673253069811, 8203.261706446448, 8204.343652507905, 8235.629396677165, 7857.528548287121, 7933.444658873824, 7940.483868548526, 7943.563104029334, 8023.1174570796, 9258.074192580958, 9296.302777291596, 9418.4819834907, 9512.714618561455, 9541.188998935168, 9504.097110774464, 9553.856692149484, 9772.511374431107, 9833.754156146153, 9848.458334791656, 6637.834054148685, 6799.490038247052, 7142.321479459443, 7347.595882226315, 7446.106467223968, 7773.727919522789, 7804.141544430222, 7808.41436892224, 7815.29662330393, 7828.84342313162, 7080.221175670775, 7198.676059577227, 7227.1327440707455, 7314.926850731425, 7334.3032411920785, 6856.108705868404, 6924.4460443165435, 6947.23580406165, 6977.755778547727, 7039.19049309336, 7264.418846492374, 7420.814479638052, 7443.441741869273, 7443.851122977402, 7511.3615342696485, 6974.79075627732, 6989.091418115816, 6996.0, 7009.264027277266, 7013.05323781283, 7117.395021423237, 7119.786406407816, 7241.493095483476, 7265.0, 7265.09186351706], "unit": "score", "name": "mootools.html", "value": 4727.780757917122}, {"lowerIsBetter": false, "replicates": [344.844819831076, 347.08542989223395, 354.79776527379386, 357.87116638010326, 363.61820088906643, 5895.380984996573, 5922.052471604544, 5951.642901425917, 5957.910631340523, 5974.3428222895445, 5885.823425297237, 5886.529077673787, 5889.823305300837, 5903.26209223847, 5910.231669882909, 4407.18467083589, 4522.140793249272, 4591.081783643268, 4598.126355992359, 4622.445306563217, 4610.170169369512, 4615.261558150696, 4624.653151013687, 4640.721556706591, 4641.744704041276, 4576.679632425731, 4584.060267645142, 4586.97706511467, 4587.8623641290815, 4599.954000459986, 4381.912361752763, 4494.348319493655, 4590.0590378972565, 4598.931016034762, 4609.216433206363, 4072.5927407259333, 4078.8572399966156, 4084.6323830855067, 4088.3458646616696, 4094.2425651254316, 5555.722213889289, 5557.638753481051, 5561.416051314594, 5565.833025009256, 5570.415106413809, 5358.4641535846495, 5358.651687640291, 5363.973180134113, 5368.758405871745, 5373.7581808818695, 6235.033569796644, 6247.843803904893, 6249.312575616678, 6250.968745156245, 6251.593646412968, 4504.09918016398, 4518.1415531049, 4519.389882365871, 4520.208963431419, 4523.389342438762, 6470.38531339522, 6480.384363485461, 6491.545591808575, 6491.93508064918, 6493.70778314977, 4640.69835460694, 4645.953540464619, 4646.883827904329, 4657.534246575316, 4657.813687452532, 4700.730802683324, 4704.670673052922, 4711.740854253049, 4712.50518695532, 4723.078999595046, 5292.2326262691695, 5296.417394086648, 5298.470152984671, 5343.332083489564, 5347.491988261109, 6085.726142323606, 6234.906476402857, 6245.875082498324, 6246.656433896089, 6261.24865016201, 1638.6640738648548, 1655.2551351891698, 1660.0371784365038, 1665.6918470083074, 1665.7168281392192, 1047.3977462958828, 1120.5853834081443, 1131.1629394248198, 1150.750283196349, 1154.4458659843322, 6005.648729035932, 6084.574079814459, 6093.207882975274, 6094.786682466092, 6095.573309868355, 6413.551051426355, 6415.0, 6425.967870160713, 6426.3573642635365, 6429.0, 6051.364606716319, 6064.120702498113, 6085.66528840918, 6086.573939824259, 6095.207623008981, 3434.364642541138, 3436.7766095203733, 3438.2951494943477, 3457.7233821294235, 3476.28736109097, 6452.225732911987, 6646.302138275508, 6658.633775142317, 6660.900951343071, 6661.134052573231, 6465.030245463124, 6467.579607325509, 6529.575577587441, 6549.803505894831, 6550.836229094215, 6684.030815531721, 6695.866082678319, 6703.966480167568, 6714.630695311805, 6735.730570777114, 6378.74485020594, 6386.521010924106, 6389.840253993687, 6402.90395644075, 6415.454686351713, 6244.562880598496, 6309.4952403806665, 6328.335524770017, 6349.523785716182, 6471.935280647322, 6800.0, 6854.074699915647, 6855.897161542481, 6864.622445765331, 6881.277465866012, 4520.547945205453, 4563.338315944103, 4573.108243892409, 4574.7941342639, 4577.8397756078375, 6561.80314590563, 6563.146790917151, 6567.179102612174, 6571.80284591463, 6578.013298005338, 6388.0, 6400.967995160181, 6404.775832845828, 6408.1349017881985, 6410.45511131559, 6219.626822390671, 6351.555391122577, 6389.7763578274535, 6398.616083035033, 6402.35976402356, 6269.905951410824, 6286.497080233479, 6298.937010630018, 6306.243250809932, 6358.141650877073, 6412.935870641234, 6422.133012043314, 6425.45383642377, 6428.035794630843, 6428.8071357859335, 6047.848803779941, 6088.756449741961, 6160.722767475564, 6249.312575616769, 6273.059041143865], "unit": "score", "name": "prototype.html", "value": 4796.172471959077}, {"lowerIsBetter": false, "replicates": [801.9518828870266, 844.4595458906299, 867.2195024477969, 888.5690440136528, 904.4618452021049, 13393.263370514618, 13655.317234138303, 13661.726765464684, 13684.247366394844, 13722.656933576653, 12834.358282085905, 12862.0, 12950.546730864422, 13129.21224726517, 13415.798763018562, 916.3951791817385, 927.1192367251139, 933.7198840347902, 934.0192797562567, 935.1069728409386, 922.0, 925.2413021322518, 926.0091701878993, 926.9443833370019, 927.184078011349, 970.1268858027796, 972.2562239886493, 972.9416235025885, 973.3964941736134, 973.4889183178817, 963.8746962894813, 964.0455948610895, 965.541367850269, 965.7875267441187, 965.9372140810825, 711.0187940641881, 712.0743034055758, 712.7006657203987, 713.1371041040347, 713.4328209073799, 12998.805017924738, 13019.218846869218, 13039.152455090389, 13187.868121318856, 13212.86787132126, 12153.210041347284, 12245.204061735958, 12320.75358492825, 12579.811302830465, 12629.810552841715, 10423.530941107669, 10756.623518176904, 10786.298890572167, 10794.784104317949, 11013.229073964825, 3809.5238095238096, 3848.634379733921, 3880.9223815523815, 3957.920841583181, 4410.933835992462, 47483.76258118687, 50470.7476462619, 51693.22460163101, 51811.0, 52566.21150682704, 11293.491792869341, 11336.376499292453, 11606.593769218036, 11639.0, 11685.0, 20180.798192018185, 20290.69563956542, 20343.0, 20372.38882833488, 20378.388648340573, 8132.0, 8139.064007639079, 8178.918210817816, 8201.589920503951, 8462.957685211657, 4368.737875727403, 4459.620932220798, 4482.372467854503, 4502.482214545304, 4615.5845973862515, 3360.1599600099976, 3404.4042292598697, 3408.4205685033603, 3408.5739282589675, 3408.744344174197, 616.1527899138684, 629.7292164369273, 634.3054355480741, 634.6445990245477, 646.8544577470126, 735.5255859970289, 742.784592468189, 750.5084169868636, 767.2519293688609, 778.9143194248628, 8671.869921951176, 8815.955920220485, 8840.734777956672, 9225.630974760934, 9266.490343031062, 659.3637140159769, 704.527966262595, 704.8167476456158, 725.2493669052611, 732.0775822463734, 4093.5497095319492, 4246.893827654333, 4278.871633850989, 4314.223439780807, 4345.847895323648, 61791.691041545404, 62390.376096238455, 62719.0, 65030.34969650243, 66345.0, 51834.22248666273, 52123.21815172776, 52793.472065279624, 53071.46928530665, 54426.0, 48578.757106214245, 48631.0, 48785.0, 52683.0, 53050.734746326794, 8976.461412315282, 9130.680426185052, 9154.221891139061, 9182.540872956459, 9402.52987350616, 36210.637893620726, 36270.45594316035, 37243.81378093092, 37559.62440375671, 38434.6156538431, 45488.77255613701, 47312.526874730815, 47865.76067119642, 48009.5199048005, 48788.2681759781, 11537.965452579323, 11654.53381864716, 11702.4733886977, 11800.0, 11971.221870578385, 13203.339833008118, 13277.535286264934, 13423.328833558478, 13619.79570306466, 14235.786463203267, 12543.372831358578, 12587.87412125867, 12713.682157946125, 12878.871211287767, 12901.741965160832, 12583.748325033264, 12834.0, 13006.219626822422, 13193.60419187426, 13214.537491187762, 12565.93717031409, 12743.362831858556, 12937.417816198105, 13046.152000119962, 13099.952003839478, 10018.098371146632, 10037.44794036335, 10216.387016779017, 10323.896761032294, 10522.894771052192, 9985.650502232678, 10139.898601013896, 10242.436665983443, 10268.948655256676, 10277.177825773771], "unit": "score", "name": "yui.html", "value": 6837.007461447789}], "name": "dromaeo_css", "value": 7211.369496233055}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 104.0, 109.0, 110.0, 110.0, 98.0, 108.0, 109.0, 109.0], "unit": "score", "name": "ai-astar", "value": 107.7}, {"lowerIsBetter": true, "replicates": [162.0, 125.0, 152.0, 175.0, 126.0, 159.0, 165.0, 133.0, 189.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 151.9}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 161.0, 161.0, 160.0, 160.0, 159.0, 165.0, 161.0, 161.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 76.0, 166.0, 76.0, 74.0, 76.0, 77.0, 163.0, 76.0], "unit": "score", "name": "audio-fft", "value": 93.2}, {"lowerIsBetter": true, "replicates": [94.0, 92.0, 147.0, 94.0, 94.0, 92.0, 144.0, 93.0, 93.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 108.4}, {"lowerIsBetter": true, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 116.9}, {"lowerIsBetter": true, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.0}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 97.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 95.9}, {"lowerIsBetter": true, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 64.0, 53.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 65.0, 68.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 65.0}, {"lowerIsBetter": true, "replicates": [77.0, 79.0, 78.0, 78.0, 77.0, 84.0, 77.0, 86.0, 78.0, 79.0], "unit": "score", "name": "stanford-crypto-aes", "value": 79.3}, {"lowerIsBetter": true, "replicates": [113.0, 120.0, 110.0, 111.0, 119.0, 111.0, 119.0, 111.0, 110.0, 110.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 113.4}, {"lowerIsBetter": true, "replicates": [155.0, 134.0, 142.0, 139.0, 153.0, 134.0, 142.0, 140.0, 152.0, 141.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 143.2}, {"lowerIsBetter": true, "replicates": [66.0, 67.0, 69.0, 65.0, 65.0, 66.0, 66.0, 65.0, 64.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1503.3000000000002}]} 05:21:01 INFO - Return code: 0 05:21:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:21:02 INFO - # TBPL SUCCESS # 05:21:02 INFO - Running post-action listener: _resource_record_post_action 05:21:02 INFO - Running post-run listener: _resource_record_post_run 05:21:03 INFO - Total resource usage - Wall time: 1188s; CPU: 13.0%; Read bytes: 286720; Write bytes: 500973568; Read time: 284; Write time: 526120 05:21:03 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 224600064; Read time: 64; Write time: 363988 05:21:03 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 282624; Write bytes: 255807488; Read time: 220; Write time: 156276 05:21:03 INFO - Running post-run listener: _upload_blobber_files 05:21:03 INFO - Blob upload gear active. 05:21:03 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:21:03 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:21:03 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:21:03 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:21:03 INFO - (blobuploader) - INFO - Open directory for files ... 05:21:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 05:21:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:21:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:04 INFO - (blobuploader) - INFO - Done attempting. 05:21:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:21:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:21:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:05 INFO - (blobuploader) - INFO - Done attempting. 05:21:05 INFO - (blobuploader) - INFO - Iteration through files over. 05:21:05 INFO - Return code: 0 05:21:05 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:21:05 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:21:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b20c5085fc77ec583553c8ff885bc991c718ad5a0b4fccad0b5274bb1cf47568882aabdc40591b2352563574354ed8c5fd9aad40afda6911d5e19ee8952e26eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b2760bd66ea9d62de7aa00cc9cbae1fd133ba9913dea353f0ff0ec554c5d8bceaae4aaa996f73937768ceb731ae904edcb2f38421198efd89699ddfaa53b317"} 05:21:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:21:05 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:21:05 INFO - Contents: 05:21:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b20c5085fc77ec583553c8ff885bc991c718ad5a0b4fccad0b5274bb1cf47568882aabdc40591b2352563574354ed8c5fd9aad40afda6911d5e19ee8952e26eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b2760bd66ea9d62de7aa00cc9cbae1fd133ba9913dea353f0ff0ec554c5d8bceaae4aaa996f73937768ceb731ae904edcb2f38421198efd89699ddfaa53b317"} 05:21:05 INFO - Running post-run listener: copy_logs_to_upload_dir 05:21:05 INFO - Copying logs to upload dir... 05:21:05 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:21:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.295872 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-04-12 05:21:04.508854) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 05:21:04.512643) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b20c5085fc77ec583553c8ff885bc991c718ad5a0b4fccad0b5274bb1cf47568882aabdc40591b2352563574354ed8c5fd9aad40afda6911d5e19ee8952e26eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b2760bd66ea9d62de7aa00cc9cbae1fd133ba9913dea353f0ff0ec554c5d8bceaae4aaa996f73937768ceb731ae904edcb2f38421198efd89699ddfaa53b317"} build_url:https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011472 build_url: 'https://queue.taskcluster.net/v1/task/QaiaEmigTXy_U5Mz4mLgpg/artifacts/public/build/firefox-47.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b20c5085fc77ec583553c8ff885bc991c718ad5a0b4fccad0b5274bb1cf47568882aabdc40591b2352563574354ed8c5fd9aad40afda6911d5e19ee8952e26eb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/3b2760bd66ea9d62de7aa00cc9cbae1fd133ba9913dea353f0ff0ec554c5d8bceaae4aaa996f73937768ceb731ae904edcb2f38421198efd89699ddfaa53b317"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 05:21:04.537679) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:21:04.537998) ========= 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=fa9c93d544b966bd2b8d485a000001c6-1460460223.801464-1479323559 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:21:04.621112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 05:21:04.621442) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 05:21:04.621859) ========= ========= Total master_lag: 0.44 =========