builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1460463455.82 results: success (0) buildid: 20160412024453 builduid: 621dd214a5334cf6b1b44c10b5d08778 revision: af47156de41a41fe20cb148971e8569a75b9aa2b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:35.817070) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:35.817513) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:35.817818) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006452 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:35.884391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:35.884724) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:35.992824) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:35.993170) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004567 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:36.056264) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:36.056557) ========= 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:17:36.056907) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:36.057204) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-12 05:17:36-- 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.1M=0s 2016-04-12 05:17:36 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174458 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:36.245725) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:36.246122) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018871 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:36.298599) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:36.298923) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev af47156de41a41fe20cb148971e8569a75b9aa2b --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev af47156de41a41fe20cb148971e8569a75b9aa2b --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=5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-12 05:17:36,742 truncating revision to first 12 chars 2016-04-12 05:17:36,742 Setting DEBUG logging. 2016-04-12 05:17:36,742 attempt 1/10 2016-04-12 05:17:36,742 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/af47156de41a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-12 05:17:37,249 unpacking tar archive at: mozilla-beta-af47156de41a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.808206 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:37.123320) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:37.123659) ========= echo af47156de41a41fe20cb148971e8569a75b9aa2b in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'af47156de41a41fe20cb148971e8569a75b9aa2b'] 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=5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False af47156de41a41fe20cb148971e8569a75b9aa2b program finished with exit code 0 elapsedTime=0.003686 script_repo_revision: 'af47156de41a41fe20cb148971e8569a75b9aa2b' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:37.171784) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:37.172106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-12 05:17:37.182089) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-12 05:17:37.182384) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:17:37 INFO - MultiFileLogger online at 20160412 05:17:37 in /builds/slave/test-pgo 05:17:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:17:37 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:17:37 INFO - {'append_to_log': False, 05:17:37 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:17:37 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:17:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:17:37 INFO - 'branch': 'Mozilla-Beta', 05:17:37 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:37 INFO - 'config_files': ('talos/linux_config.py',), 05:17:37 INFO - 'default_actions': ('clobber', 05:17:37 INFO - 'read-buildbot-config', 05:17:37 INFO - 'download-and-extract', 05:17:37 INFO - 'populate-webroot', 05:17:37 INFO - 'create-virtualenv', 05:17:37 INFO - 'install', 05:17:37 INFO - 'run-tests'), 05:17:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:37 INFO - 'download_minidump_stackwalk': True, 05:17:37 INFO - 'download_symbols': 'ondemand', 05:17:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:37 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:37 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:37 INFO - 'installer_path': 'installer.exe', 05:17:37 INFO - 'log_level': 'info', 05:17:37 INFO - 'log_name': 'talos', 05:17:37 INFO - 'log_to_console': True, 05:17:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:17:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:17:37 INFO - 'opt_config_files': (), 05:17:37 INFO - 'pip_index': False, 05:17:37 INFO - 'sps_profile': False, 05:17:37 INFO - 'sps_profile_interval': 0, 05:17:37 INFO - 'suite': 'dromaeojs-e10s', 05:17:37 INFO - 'system_bits': '32', 05:17:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:37 INFO - 'title': 'talos-linux64-ix-011', 05:17:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:37 INFO - 'use_talos_json': True, 05:17:37 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:17:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:37 INFO - 'work_dir': 'build'} 05:17:37 INFO - ##### 05:17:37 INFO - ##### Running clobber step. 05:17:37 INFO - ##### 05:17:37 INFO - Running pre-action listener: _resource_record_pre_action 05:17:37 INFO - Running main action method: clobber 05:17:37 INFO - rmtree: /builds/slave/test-pgo/build 05:17:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:17:38 INFO - Running post-action listener: _resource_record_post_action 05:17:38 INFO - ##### 05:17:38 INFO - ##### Running read-buildbot-config step. 05:17:38 INFO - ##### 05:17:38 INFO - Running pre-action listener: _resource_record_pre_action 05:17:38 INFO - Running main action method: read_buildbot_config 05:17:38 INFO - Using buildbot properties: 05:17:38 INFO - { 05:17:38 INFO - "project": "", 05:17:38 INFO - "product": "firefox", 05:17:38 INFO - "script_repo_revision": "production", 05:17:38 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs-e10s", 05:17:38 INFO - "repository": "", 05:17:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs-e10s", 05:17:38 INFO - "buildid": "20160412024453", 05:17:38 INFO - "pgo_build": "True", 05:17:38 INFO - "basedir": "/builds/slave/test-pgo", 05:17:38 INFO - "buildnumber": 57, 05:17:38 INFO - "slavename": "talos-linux64-ix-011", 05:17:38 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:17:38 INFO - "platform": "ubuntu64_hw", 05:17:38 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 05:17:38 INFO - "branch": "mozilla-beta", 05:17:38 INFO - "repo_path": "releases/mozilla-beta", 05:17:38 INFO - "revision": "af47156de41a41fe20cb148971e8569a75b9aa2b", 05:17:38 INFO - "stage_platform": "linux64-pgo", 05:17:38 INFO - "builduid": "621dd214a5334cf6b1b44c10b5d08778", 05:17:38 INFO - "slavebuilddir": "test" 05:17:38 INFO - } 05:17:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2. 05:17:38 INFO - Running post-action listener: _resource_record_post_action 05:17:38 INFO - ##### 05:17:38 INFO - ##### Running download-and-extract step. 05:17:38 INFO - ##### 05:17:38 INFO - Running pre-action listener: _resource_record_pre_action 05:17:38 INFO - Running main action method: download_and_extract 05:17:38 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:17:38 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:17:38 INFO - https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:17:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/test_packages.json 05:17:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/test_packages.json 05:17:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:17:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:17:39 INFO - Downloaded 1412 bytes. 05:17:39 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:17:39 INFO - Using the following test package requirements: 05:17:39 INFO - {u'common': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 05:17:39 INFO - u'cppunittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 05:17:39 INFO - u'firefox-46.0.en-US.linux-x86_64.cppunittest.tests.zip'], 05:17:39 INFO - u'gtest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 05:17:39 INFO - u'firefox-46.0.en-US.linux-x86_64.gtest.tests.zip'], 05:17:39 INFO - u'jittest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 05:17:39 INFO - u'jsshell-linux-x86_64.zip'], 05:17:39 INFO - u'mochitest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 05:17:39 INFO - u'firefox-46.0.en-US.linux-x86_64.mochitest.tests.zip'], 05:17:39 INFO - u'mozbase': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 05:17:39 INFO - u'reftest': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 05:17:39 INFO - u'firefox-46.0.en-US.linux-x86_64.reftest.tests.zip'], 05:17:39 INFO - u'talos': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 05:17:39 INFO - u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'], 05:17:39 INFO - u'web-platform': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 05:17:39 INFO - u'firefox-46.0.en-US.linux-x86_64.web-platform.tests.zip'], 05:17:39 INFO - u'webapprt': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'], 05:17:39 INFO - u'xpcshell': [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', 05:17:39 INFO - u'firefox-46.0.en-US.linux-x86_64.xpcshell.tests.zip']} 05:17:39 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:17:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:39 INFO - https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 05:17:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 05:17:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 05:17:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:17:40 INFO - Downloaded 23147087 bytes. 05:17:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:17:40 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:17:42 INFO - Return code: 0 05:17:42 INFO - Downloading packages: [u'firefox-46.0.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:17:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:42 INFO - https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:17:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 05:17:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 05:17:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip 05:17:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:17:47 INFO - Downloaded 23147087 bytes. 05:17:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:17:47 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:17:48 INFO - Return code: 0 05:17:48 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:17:48 INFO - https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:17:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 05:17:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 05:17:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip 05:17:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:17:49 INFO - Downloaded 10801548 bytes. 05:17:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:17:49 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:17:49 INFO - Return code: 0 05:17:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:17:49 INFO - https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:17:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 05:17:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 05:17:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 05:17:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:17:51 INFO - Downloaded 52876492 bytes. 05:17:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 05:17:51 INFO - mkdir: /builds/slave/test-pgo/properties 05:17:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:17:51 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:17:51 INFO - Contents: 05:17:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 05:17:52 INFO - Running post-action listener: _resource_record_post_action 05:17:52 INFO - Running post-action listener: set_extra_try_arguments 05:17:52 INFO - ##### 05:17:52 INFO - ##### Running populate-webroot step. 05:17:52 INFO - ##### 05:17:52 INFO - Running pre-action listener: _resource_record_pre_action 05:17:52 INFO - Running main action method: populate_webroot 05:17:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:52 INFO - '--tppagecycles', 05:17:52 INFO - '7'], 05:17:52 INFO - 'tests': ['tsvgm']}}, 05:17:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:17:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:17:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:17:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:17:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:17:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:52 INFO - 'talos_options': ['--e10s'], 05:17:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:52 INFO - 'tests': ['damp', 'tps']}, 05:17:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:52 INFO - 'talos_options': ['--e10s'], 05:17:52 INFO - 'tests': ['damp', 'tps']}, 05:17:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:17:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:52 INFO - 'other': {'tests': ['a11yr', 05:17:52 INFO - 'ts_paint', 05:17:52 INFO - 'tpaint', 05:17:52 INFO - 'sessionrestore', 05:17:52 INFO - 'sessionrestore_no_auto_restore']}, 05:17:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:17:52 INFO - 'tests': ['a11yr', 05:17:52 INFO - 'ts_paint', 05:17:52 INFO - 'tpaint', 05:17:52 INFO - 'sessionrestore', 05:17:52 INFO - 'sessionrestore_no_auto_restore']}, 05:17:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:17:52 INFO - 'tests': ['a11yr', 05:17:52 INFO - 'ts_paint', 05:17:52 INFO - 'tpaint', 05:17:52 INFO - 'sessionrestore', 05:17:52 INFO - 'sessionrestore_no_auto_restore']}, 05:17:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:17:52 INFO - 'tests': ['a11yr', 05:17:52 INFO - 'ts_paint', 05:17:52 INFO - 'tpaint', 05:17:52 INFO - 'sessionrestore', 05:17:52 INFO - 'sessionrestore_no_auto_restore']}, 05:17:52 INFO - 'other_l64': {'tests': ['a11yr', 05:17:52 INFO - 'ts_paint', 05:17:52 INFO - 'tpaint', 05:17:52 INFO - 'sessionrestore', 05:17:52 INFO - 'sessionrestore_no_auto_restore']}, 05:17:52 INFO - 'other_nol64': {'tests': ['a11yr', 05:17:52 INFO - 'ts_paint', 05:17:52 INFO - 'tpaint', 05:17:52 INFO - 'sessionrestore', 05:17:52 INFO - 'sessionrestore_no_auto_restore']}, 05:17:52 INFO - 'svgr': {'tests': ['tsvgx', 05:17:52 INFO - 'tsvgr_opacity', 05:17:52 INFO - 'tart', 05:17:52 INFO - 'tscrollx', 05:17:52 INFO - 'cart']}, 05:17:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:17:52 INFO - 'tests': ['tsvgx', 05:17:52 INFO - 'tsvgr_opacity', 05:17:52 INFO - 'tart', 05:17:52 INFO - 'tscrollx', 05:17:52 INFO - 'cart']}, 05:17:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:52 INFO - 'tests': ['tp5o']}, 05:17:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:52 INFO - 'talos_options': ['--e10s'], 05:17:52 INFO - 'tests': ['tp5o']}, 05:17:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:52 INFO - 'talos_options': ['--xperf_path', 05:17:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:52 INFO - 'tests': ['tp5n']}, 05:17:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:52 INFO - 'talos_options': ['--e10s', 05:17:52 INFO - '--xperf_path', 05:17:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:52 INFO - 'tests': ['tp5n']}}, 05:17:52 INFO - 'talos.zip': {'path': '', 05:17:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:52 INFO - Running post-action listener: _resource_record_post_action 05:17:52 INFO - ##### 05:17:52 INFO - ##### Running create-virtualenv step. 05:17:52 INFO - ##### 05:17:52 INFO - Running pre-action listener: _resource_record_pre_action 05:17:52 INFO - Running main action method: create_virtualenv 05:17:52 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:17:52 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:17:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:17:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:52 INFO - Using real prefix '/usr' 05:17:52 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:17:53 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:55 INFO - Installing pip.................done. 05:17:55 INFO - Return code: 0 05:17:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:17:55 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:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:55 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:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:55 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 0x7fdd8d312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', '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:17:55 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:17:55 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:17:55 INFO - Using env: {'DISPLAY': ':0', 05:17:55 INFO - 'HOME': '/home/cltbld', 05:17:55 INFO - 'LANG': 'en_US.UTF-8', 05:17:55 INFO - 'LANGUAGE': 'en_US:en', 05:17:55 INFO - 'LOGNAME': 'cltbld', 05:17:55 INFO - 'MAIL': '/var/mail/cltbld', 05:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:55 INFO - 'MOZ_NO_REMOTE': '1', 05:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:55 INFO - 'NO_EM_RESTART': '1', 05:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:17:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:17:55 INFO - 'SHELL': '/bin/bash', 05:17:55 INFO - 'SHLVL': '1', 05:17:55 INFO - 'TERM': 'linux', 05:17:55 INFO - 'TMOUT': '86400', 05:17:55 INFO - 'USER': 'cltbld', 05:17:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:55 INFO - '_': '/tools/buildbot/bin/python'} 05:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:55 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:17:55 INFO - Cleaning up... 05:17:55 INFO - Return code: 0 05:17:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:17:55 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:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:55 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:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:55 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 0x7fdd8d312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', '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:17:55 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:17:55 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:17:55 INFO - Using env: {'DISPLAY': ':0', 05:17:55 INFO - 'HOME': '/home/cltbld', 05:17:55 INFO - 'LANG': 'en_US.UTF-8', 05:17:55 INFO - 'LANGUAGE': 'en_US:en', 05:17:55 INFO - 'LOGNAME': 'cltbld', 05:17:55 INFO - 'MAIL': '/var/mail/cltbld', 05:17:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:55 INFO - 'MOZ_NO_REMOTE': '1', 05:17:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:55 INFO - 'NO_EM_RESTART': '1', 05:17:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:17:55 INFO - 'PWD': '/builds/slave/test-pgo', 05:17:55 INFO - 'SHELL': '/bin/bash', 05:17:55 INFO - 'SHLVL': '1', 05:17:55 INFO - 'TERM': 'linux', 05:17:55 INFO - 'TMOUT': '86400', 05:17:55 INFO - 'USER': 'cltbld', 05:17:55 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:17:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:55 INFO - '_': '/tools/buildbot/bin/python'} 05:17:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:55 INFO - Downloading/unpacking psutil>=0.7.1 05:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:57 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:57 INFO - Installing collected packages: psutil 05:17:57 INFO - Running setup.py install for psutil 05:17:57 INFO - building 'psutil._psutil_linux' extension 05:17:57 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:17:57 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:17:58 INFO - building 'psutil._psutil_posix' extension 05:17:58 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:17:58 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:17:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:58 INFO - Successfully installed psutil 05:17:58 INFO - Cleaning up... 05:17:58 INFO - Return code: 0 05:17:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:17:58 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:17:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:58 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:17:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:58 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 0x7fdd8d312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', '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:17:58 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:17:58 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:17:58 INFO - Using env: {'DISPLAY': ':0', 05:17:58 INFO - 'HOME': '/home/cltbld', 05:17:58 INFO - 'LANG': 'en_US.UTF-8', 05:17:58 INFO - 'LANGUAGE': 'en_US:en', 05:17:58 INFO - 'LOGNAME': 'cltbld', 05:17:58 INFO - 'MAIL': '/var/mail/cltbld', 05:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:58 INFO - 'MOZ_NO_REMOTE': '1', 05:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:17:58 INFO - 'NO_EM_RESTART': '1', 05:17:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:17:58 INFO - 'PWD': '/builds/slave/test-pgo', 05:17:58 INFO - 'SHELL': '/bin/bash', 05:17:58 INFO - 'SHLVL': '1', 05:17:58 INFO - 'TERM': 'linux', 05:17:58 INFO - 'TMOUT': '86400', 05:17:58 INFO - 'USER': 'cltbld', 05:17:58 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:58 INFO - '_': '/tools/buildbot/bin/python'} 05:17:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:17:58 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:17:58 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:17:58 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:17:58 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:17:58 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:17:58 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:18:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:18:00 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:18:00 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:18:00 INFO - Installing collected packages: mozsystemmonitor 05:18:00 INFO - Running setup.py install for mozsystemmonitor 05:18:00 INFO - Successfully installed mozsystemmonitor 05:18:00 INFO - Cleaning up... 05:18:00 INFO - Return code: 0 05:18:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:18: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:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:00 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 0x7fdd8d312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', '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:18:00 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:18:00 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:18:00 INFO - Using env: {'DISPLAY': ':0', 05:18:00 INFO - 'HOME': '/home/cltbld', 05:18:00 INFO - 'LANG': 'en_US.UTF-8', 05:18:00 INFO - 'LANGUAGE': 'en_US:en', 05:18:00 INFO - 'LOGNAME': 'cltbld', 05:18:00 INFO - 'MAIL': '/var/mail/cltbld', 05:18:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:00 INFO - 'MOZ_NO_REMOTE': '1', 05:18:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:00 INFO - 'NO_EM_RESTART': '1', 05:18:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:00 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:00 INFO - 'SHELL': '/bin/bash', 05:18:00 INFO - 'SHLVL': '1', 05:18:00 INFO - 'TERM': 'linux', 05:18:00 INFO - 'TMOUT': '86400', 05:18:00 INFO - 'USER': 'cltbld', 05:18:00 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:18:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:00 INFO - '_': '/tools/buildbot/bin/python'} 05:18:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:00 INFO - Downloading/unpacking blobuploader==1.2.4 05:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:02 INFO - Downloading blobuploader-1.2.4.tar.gz 05:18:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:18:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:02 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:18:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:03 INFO - Downloading docopt-0.6.1.tar.gz 05:18:03 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:18:03 INFO - Installing collected packages: blobuploader, requests, docopt 05:18:03 INFO - Running setup.py install for blobuploader 05:18:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:18:03 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:18:03 INFO - Running setup.py install for requests 05:18:03 INFO - Running setup.py install for docopt 05:18:03 INFO - Successfully installed blobuploader requests docopt 05:18:03 INFO - Cleaning up... 05:18:04 INFO - Return code: 0 05:18:04 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:18:04 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:18:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:04 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:18:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:04 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 0x7fdd8d312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', '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:18:04 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:18:04 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:18:04 INFO - Using env: {'DISPLAY': ':0', 05:18:04 INFO - 'HOME': '/home/cltbld', 05:18:04 INFO - 'LANG': 'en_US.UTF-8', 05:18:04 INFO - 'LANGUAGE': 'en_US:en', 05:18:04 INFO - 'LOGNAME': 'cltbld', 05:18:04 INFO - 'MAIL': '/var/mail/cltbld', 05:18:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:04 INFO - 'MOZ_NO_REMOTE': '1', 05:18:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:04 INFO - 'NO_EM_RESTART': '1', 05:18:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:04 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:04 INFO - 'SHELL': '/bin/bash', 05:18:04 INFO - 'SHLVL': '1', 05:18:04 INFO - 'TERM': 'linux', 05:18:04 INFO - 'TMOUT': '86400', 05:18:04 INFO - 'USER': 'cltbld', 05:18:04 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:18:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:04 INFO - '_': '/tools/buildbot/bin/python'} 05:18:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:18:04 INFO - Running setup.py (path:/tmp/pip-gIdQMc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:18:04 INFO - Running setup.py (path:/tmp/pip-9Zc6SQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:18:04 INFO - Running setup.py (path:/tmp/pip-PD1qHn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:18:04 INFO - Running setup.py (path:/tmp/pip-8T_wkQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:18:04 INFO - Running setup.py (path:/tmp/pip-t0JTh9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:18:04 INFO - Running setup.py (path:/tmp/pip-POAU9A-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:18:04 INFO - Running setup.py (path:/tmp/pip-NaTDz7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:18:04 INFO - Running setup.py (path:/tmp/pip-Jzothk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:18:04 INFO - Running setup.py (path:/tmp/pip-vv1var-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:18:04 INFO - Running setup.py (path:/tmp/pip-dOfBLj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:18:04 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:18:04 INFO - Running setup.py (path:/tmp/pip-xdU7VY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:18:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:18:05 INFO - Running setup.py (path:/tmp/pip-yvRL6k-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:18:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:18:05 INFO - Running setup.py (path:/tmp/pip-EceHPl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:18:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:18:05 INFO - Running setup.py (path:/tmp/pip-r5EqAI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:18:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:18:05 INFO - Running setup.py (path:/tmp/pip-bNLGOn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:18:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:18:05 INFO - Running setup.py (path:/tmp/pip-5oRPsv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:18:05 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:18:05 INFO - Running setup.py (path:/tmp/pip-RLiJcn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:18:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:18:05 INFO - Running setup.py install for manifestparser 05:18:05 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:18:05 INFO - Running setup.py install for mozcrash 05:18:05 INFO - Running setup.py install for mozdebug 05:18:05 INFO - Running setup.py install for mozdevice 05:18:05 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:18:05 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:18:05 INFO - Running setup.py install for mozfile 05:18:05 INFO - Running setup.py install for mozhttpd 05:18:06 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Running setup.py install for mozinfo 05:18:06 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Running setup.py install for mozInstall 05:18:06 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Running setup.py install for mozleak 05:18:06 INFO - Running setup.py install for mozlog 05:18:06 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Running setup.py install for moznetwork 05:18:06 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Running setup.py install for mozprocess 05:18:06 INFO - Running setup.py install for mozprofile 05:18:06 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Running setup.py install for mozrunner 05:18:06 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:18:06 INFO - Running setup.py install for mozscreenshot 05:18:07 INFO - Running setup.py install for moztest 05:18:07 INFO - Running setup.py install for mozversion 05:18:07 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:18:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:18:07 INFO - Cleaning up... 05:18:07 INFO - Return code: 0 05:18:07 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:18: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:18:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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/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 0x7fdd8d312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', '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:18:07 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:18:07 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:18:07 INFO - Using env: {'DISPLAY': ':0', 05:18:07 INFO - 'HOME': '/home/cltbld', 05:18:07 INFO - 'LANG': 'en_US.UTF-8', 05:18:07 INFO - 'LANGUAGE': 'en_US:en', 05:18:07 INFO - 'LOGNAME': 'cltbld', 05:18:07 INFO - 'MAIL': '/var/mail/cltbld', 05:18:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:07 INFO - 'MOZ_NO_REMOTE': '1', 05:18:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:07 INFO - 'NO_EM_RESTART': '1', 05:18:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:07 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:07 INFO - 'SHELL': '/bin/bash', 05:18:07 INFO - 'SHLVL': '1', 05:18:07 INFO - 'TERM': 'linux', 05:18:07 INFO - 'TMOUT': '86400', 05:18:07 INFO - 'USER': 'cltbld', 05:18:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:18:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:07 INFO - '_': '/tools/buildbot/bin/python'} 05:18:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:18:07 INFO - Running setup.py (path:/tmp/pip-4P5Th9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:18:07 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:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:18:07 INFO - Running setup.py (path:/tmp/pip-wXGhAs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:18:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:18:07 INFO - Running setup.py (path:/tmp/pip-D9NOxg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:18:07 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:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:18:07 INFO - Running setup.py (path:/tmp/pip-FUOhvJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:18:07 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:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:18:07 INFO - Running setup.py (path:/tmp/pip-3j4cbE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:18:07 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:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:18:07 INFO - Running setup.py (path:/tmp/pip-019dHQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:18:07 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:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:18:07 INFO - Running setup.py (path:/tmp/pip-yWNlNo-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:18:07 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:18:07 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:18:07 INFO - Running setup.py (path:/tmp/pip-hY1qH3-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:18:08 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:18:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:18:08 INFO - Running setup.py (path:/tmp/pip-qjjajz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:18:08 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:18:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:18:08 INFO - Running setup.py (path:/tmp/pip-Cs3P0x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:18:08 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:18:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:18:08 INFO - Running setup.py (path:/tmp/pip-_uBnkz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:18:08 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:18:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:18:08 INFO - Running setup.py (path:/tmp/pip-cKwdzk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:18:08 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:18:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:18:08 INFO - Running setup.py (path:/tmp/pip-izyY5f-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:18:08 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:18:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:18:08 INFO - Running setup.py (path:/tmp/pip-I4BVD8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:18:08 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:18:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:18:08 INFO - Running setup.py (path:/tmp/pip-snh8Ri-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:18:08 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:18:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:18:08 INFO - Running setup.py (path:/tmp/pip-7cZ58v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:18:08 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:18:08 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:18:08 INFO - Running setup.py (path:/tmp/pip-bzbAEn-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:18:08 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:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:18:08 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:18:08 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:18:08 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:18:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:08 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:18:10 INFO - Downloading blessings-1.6.tar.gz 05:18:10 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:18:10 INFO - Installing collected packages: blessings 05:18:10 INFO - Running setup.py install for blessings 05:18:10 INFO - Successfully installed blessings 05:18:10 INFO - Cleaning up... 05:18:10 INFO - Return code: 0 05:18:10 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:18:10 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:18:10 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:18:10 INFO - Reading from file tmpfile_stdout 05:18:10 INFO - Current package versions: 05:18:10 INFO - argparse == 1.2.1 05:18:10 INFO - blessings == 1.6 05:18:10 INFO - blobuploader == 1.2.4 05:18:10 INFO - docopt == 0.6.1 05:18:10 INFO - manifestparser == 1.1 05:18:10 INFO - mozInstall == 1.12 05:18:10 INFO - mozcrash == 0.16 05:18:10 INFO - mozdebug == 0.1 05:18:10 INFO - mozdevice == 0.48 05:18:10 INFO - mozfile == 1.2 05:18:10 INFO - mozhttpd == 0.7 05:18:10 INFO - mozinfo == 0.9 05:18:10 INFO - mozleak == 0.1 05:18:10 INFO - mozlog == 3.1 05:18:10 INFO - moznetwork == 0.27 05:18:10 INFO - mozprocess == 0.22 05:18:10 INFO - mozprofile == 0.28 05:18:10 INFO - mozrunner == 6.11 05:18:10 INFO - mozscreenshot == 0.1 05:18:10 INFO - mozsystemmonitor == 0.0 05:18:10 INFO - moztest == 0.7 05:18:10 INFO - mozversion == 1.4 05:18:10 INFO - psutil == 3.1.1 05:18:10 INFO - requests == 1.2.3 05:18:10 INFO - wsgiref == 0.1.2 05:18:10 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:18: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:18:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18: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:18:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:10 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 0x7fdd8d312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', '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:18:10 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:18:10 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:18:10 INFO - Using env: {'DISPLAY': ':0', 05:18:10 INFO - 'HOME': '/home/cltbld', 05:18:10 INFO - 'LANG': 'en_US.UTF-8', 05:18:10 INFO - 'LANGUAGE': 'en_US:en', 05:18:10 INFO - 'LOGNAME': 'cltbld', 05:18:10 INFO - 'MAIL': '/var/mail/cltbld', 05:18:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:10 INFO - 'MOZ_NO_REMOTE': '1', 05:18:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:10 INFO - 'NO_EM_RESTART': '1', 05:18:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:10 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:10 INFO - 'SHELL': '/bin/bash', 05:18:10 INFO - 'SHLVL': '1', 05:18:10 INFO - 'TERM': 'linux', 05:18:10 INFO - 'TMOUT': '86400', 05:18:10 INFO - 'USER': 'cltbld', 05:18:10 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:18:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:10 INFO - '_': '/tools/buildbot/bin/python'} 05:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:11 INFO - Cleaning up... 05:18:11 INFO - Return code: 0 05:18:11 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:18:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:11 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 0x7fdd8d312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', '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:18:11 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:18:11 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:18:11 INFO - Using env: {'DISPLAY': ':0', 05:18:11 INFO - 'HOME': '/home/cltbld', 05:18:11 INFO - 'LANG': 'en_US.UTF-8', 05:18:11 INFO - 'LANGUAGE': 'en_US:en', 05:18:11 INFO - 'LOGNAME': 'cltbld', 05:18:11 INFO - 'MAIL': '/var/mail/cltbld', 05:18:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:11 INFO - 'MOZ_NO_REMOTE': '1', 05:18:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:11 INFO - 'NO_EM_RESTART': '1', 05:18:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:11 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:11 INFO - 'SHELL': '/bin/bash', 05:18:11 INFO - 'SHLVL': '1', 05:18:11 INFO - 'TERM': 'linux', 05:18:11 INFO - 'TMOUT': '86400', 05:18:11 INFO - 'USER': 'cltbld', 05:18:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:18:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:11 INFO - '_': '/tools/buildbot/bin/python'} 05:18:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:11 INFO - Downloading/unpacking jsonschema 05:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:11 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:18:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:18:13 INFO - Downloading/unpacking functools32 (from jsonschema) 05:18:13 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:18:13 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:18:13 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:18:13 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:18:13 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:18:13 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:18:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:18:13 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:18:13 INFO - warning: no files found matching '*.txt' 05:18:13 INFO - no previously-included directories found matching 'build' 05:18:13 INFO - no previously-included directories found matching 'dist' 05:18:13 INFO - no previously-included directories found matching '.git*' 05:18:13 INFO - Installing collected packages: jsonschema, functools32 05:18:13 INFO - Running setup.py install for functools32 05:18:13 INFO - warning: no files found matching '*.txt' 05:18:13 INFO - no previously-included directories found matching 'build' 05:18:13 INFO - no previously-included directories found matching 'dist' 05:18:13 INFO - no previously-included directories found matching '.git*' 05:18:13 INFO - Successfully installed jsonschema functools32 05:18:13 INFO - Cleaning up... 05:18:13 INFO - Return code: 0 05:18:13 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:18:13 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:18:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:18:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:13 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:18:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:18:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:18:13 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 0x7fdd8d312f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1aab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b7a290>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, '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': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', '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:18:13 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:18:13 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:18:13 INFO - Using env: {'DISPLAY': ':0', 05:18:13 INFO - 'HOME': '/home/cltbld', 05:18:13 INFO - 'LANG': 'en_US.UTF-8', 05:18:13 INFO - 'LANGUAGE': 'en_US:en', 05:18:13 INFO - 'LOGNAME': 'cltbld', 05:18:13 INFO - 'MAIL': '/var/mail/cltbld', 05:18:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:13 INFO - 'MOZ_NO_REMOTE': '1', 05:18:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:13 INFO - 'NO_EM_RESTART': '1', 05:18:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:13 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:13 INFO - 'SHELL': '/bin/bash', 05:18:13 INFO - 'SHLVL': '1', 05:18:13 INFO - 'TERM': 'linux', 05:18:13 INFO - 'TMOUT': '86400', 05:18:13 INFO - 'USER': 'cltbld', 05:18:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:18:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:13 INFO - '_': '/tools/buildbot/bin/python'} 05:18:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:18:13 INFO - Downloading/unpacking flake8 05:18:13 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:18:13 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:18:13 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:18:13 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:18:13 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:18:13 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:18:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:18:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:18:15 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:18:15 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:18:15 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:18:15 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:18:15 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:18:15 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:18:16 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:18:16 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:18:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:18:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:18:16 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:18:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:16 INFO - no previously-included directories found matching 'docs/_build' 05:18:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:18:16 INFO - Running setup.py install for pep8 05:18:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:18:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:18:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:18:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:18:16 INFO - no previously-included directories found matching 'docs/_build' 05:18:16 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:18:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:18:16 INFO - Cleaning up... 05:18:16 INFO - Return code: 0 05:18:16 INFO - Running post-action listener: _resource_record_post_action 05:18:16 INFO - Running post-action listener: _start_resource_monitoring 05:18:16 INFO - Starting resource monitoring. 05:18:16 INFO - ##### 05:18:16 INFO - ##### Running install step. 05:18:16 INFO - ##### 05:18:16 INFO - Running pre-action listener: _resource_record_pre_action 05:18:16 INFO - Running main action method: install 05:18:16 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:18:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:18:17 INFO - Reading from file tmpfile_stdout 05:18:17 INFO - Detecting whether we're running mozinstall >=1.0... 05:18:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:18:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:18:17 INFO - Reading from file tmpfile_stdout 05:18:17 INFO - Output received: 05:18:17 INFO - Usage: mozinstall [options] installer 05:18:17 INFO - Options: 05:18:17 INFO - -h, --help show this help message and exit 05:18:17 INFO - -d DEST, --destination=DEST 05:18:17 INFO - Directory to install application into. [default: 05:18:17 INFO - "/builds/slave/test-pgo"] 05:18:17 INFO - --app=APP Application being installed. [default: firefox] 05:18:17 INFO - mkdir: /builds/slave/test-pgo/build/application 05:18:17 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:18:17 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:18:29 INFO - Reading from file tmpfile_stdout 05:18:29 INFO - Output received: 05:18:29 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:18:29 INFO - Running post-action listener: _resource_record_post_action 05:18:29 INFO - ##### 05:18:29 INFO - ##### Running run-tests step. 05:18:29 INFO - ##### 05:18:29 INFO - Running pre-action listener: _resource_record_pre_action 05:18:29 INFO - Running main action method: run_tests 05:18:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:18:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:18:29 INFO - Python 2.7.3 05:18:29 INFO - Return code: 0 05:18:29 INFO - grabbing minidump binary from tooltool 05:18:29 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:18:29 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 0x1c0c850>, '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 0x1b78330>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1b787c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:18:29 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:18:29 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:18:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:29 INFO - Return code: 0 05:18:29 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:18:29 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:18:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:18:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:18:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:18:29 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:18:29 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:18:30 INFO - Return code: 0 05:18:30 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:18:30 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:18:30 INFO - Using env: {'DISPLAY': ':0', 05:18:30 INFO - 'HOME': '/home/cltbld', 05:18:30 INFO - 'LANG': 'en_US.UTF-8', 05:18:30 INFO - 'LANGUAGE': 'en_US:en', 05:18:30 INFO - 'LOGNAME': 'cltbld', 05:18:30 INFO - 'MAIL': '/var/mail/cltbld', 05:18:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:18:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:30 INFO - 'MOZ_NO_REMOTE': '1', 05:18:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:18:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:18:30 INFO - 'NO_EM_RESTART': '1', 05:18:30 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:18:30 INFO - 'PWD': '/builds/slave/test-pgo', 05:18:30 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:18:30 INFO - 'SHELL': '/bin/bash', 05:18:30 INFO - 'SHLVL': '1', 05:18:30 INFO - 'TERM': 'linux', 05:18:30 INFO - 'TMOUT': '86400', 05:18:30 INFO - 'USER': 'cltbld', 05:18:30 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483', 05:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:30 INFO - '_': '/tools/buildbot/bin/python'} 05:18:30 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:18:31 INFO - mozversion application_buildid: 20160412024453 05:18:31 INFO - mozversion application_changeset: af47156de41a41fe20cb148971e8569a75b9aa2b 05:18:31 INFO - mozversion application_display_name: Firefox 05:18:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:31 INFO - mozversion application_name: Firefox 05:18:31 INFO - mozversion application_remotingname: firefox 05:18:31 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:18:31 INFO - mozversion application_vendor: Mozilla 05:18:31 INFO - mozversion application_version: 46.0 05:18:31 INFO - mozversion platform_buildid: 20160412024453 05:18:31 INFO - mozversion platform_changeset: af47156de41a41fe20cb148971e8569a75b9aa2b 05:18:31 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:18:31 INFO - mozversion platform_version: 46.0 05:18:31 INFO - using testdate: 1460463511 05:18:31 INFO - actual date: 1460463511 05:18:31 INFO - starting webserver on 'localhost:58429' 05:18:31 INFO - SUITE-START | Running 3 tests 05:18:31 INFO - TEST-START | dromaeo_css 05:18:31 INFO - operating with platform_type : linux_ 05:18:31 INFO - Initialising browser for dromaeo_css test... 05:18:31 INFO - TEST-INFO | started process 30918 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFICNp6/profile http://localhost:58429/getInfo.html) 05:18:35 INFO - PROCESS | 30918 | 05:18:35 INFO - PROCESS | 30918 | (process:30998): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:18:36 INFO - PROCESS | 30918 | __metrics Screen width/height:1600/1200 05:18:36 INFO - PROCESS | 30918 | colorDepth:24 05:18:36 INFO - PROCESS | 30918 | Browser inner width/height: 1024/697 05:18:36 INFO - PROCESS | 30918 | __metrics 05:18:37 INFO - PROCESS | 30918 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:18:37 INFO - TEST-INFO | 30918: exit 0 05:18:37 INFO - Browser initialized. 05:18:37 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:37 INFO - TEST-INFO | started process 31046 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpFICNp6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:39 INFO - PROCESS | 31046 | 05:18:39 INFO - PROCESS | 31046 | (process:31110): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:18:49 INFO - PROCESS | 31046 | RSS: Main: 138792960 05:18:49 INFO - PROCESS | 31046 | 05:19:39 INFO - PROCESS | 31046 | 1460463579292 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:21:46 INFO - PROCESS | 31046 | Cycle 1(1): loaded http://localhost:58429/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58429/tests/dromaeo/cssquery-ext.html) 05:21:47 INFO - PROCESS | 31046 | RSS: Main: 144928768 05:21:47 INFO - PROCESS | 31046 | 05:24:49 INFO - PROCESS | 31046 | Cycle 1(1): loaded http://localhost:58429/tests/dromaeo/cssquery-ext.html (next: http://localhost:58429/tests/dromaeo/cssquery-jquery.html) 05:24:50 INFO - PROCESS | 31046 | RSS: Main: 143888384 05:24:50 INFO - PROCESS | 31046 | 05:27:51 INFO - PROCESS | 31046 | Cycle 1(1): loaded http://localhost:58429/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58429/tests/dromaeo/cssquery-mootools.html) 05:27:52 INFO - PROCESS | 31046 | RSS: Main: 142639104 05:27:52 INFO - PROCESS | 31046 | 05:30:53 INFO - PROCESS | 31046 | Cycle 1(1): loaded http://localhost:58429/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58429/tests/dromaeo/cssquery-prototype.html) 05:30:54 INFO - PROCESS | 31046 | RSS: Main: 142934016 05:30:54 INFO - PROCESS | 31046 | 05:33:56 INFO - PROCESS | 31046 | Cycle 1(1): loaded http://localhost:58429/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58429/tests/dromaeo/cssquery-yui.html) 05:33:57 INFO - PROCESS | 31046 | RSS: Main: 144252928 05:33:57 INFO - PROCESS | 31046 | 05:36:59 INFO - PROCESS | 31046 | Cycle 1(1): loaded http://localhost:58429/tests/dromaeo/cssquery-yui.html (next: http://localhost:58429/tests/dromaeo/cssquery-dojo.html) 05:36:59 INFO - PROCESS | 31046 | RSS: Main: 146046976 05:36:59 INFO - PROCESS | 31046 | 05:36:59 INFO - PROCESS | 31046 | __start_tp_report 05:36:59 INFO - PROCESS | 31046 | _x_x_mozilla_page_load 05:36:59 INFO - PROCESS | 31046 | _x_x_mozilla_page_load_details 05:36:59 INFO - PROCESS | 31046 | |i|pagename|runs| 05:36:59 INFO - PROCESS | 31046 | |0;dojo.html;3276.1318250663576;3296.6538513456085;3312.403767321881;3329.8501567429457;3347.6652334766513;5313.20301954707;5314.867128321794;5342.198670199472;5369.087255166622;5370.1407774756;5282.260483532308;5352.973235133829;5372.355317361922;5378.569714422846;5407.540359069474;4900.264960255954;4961.652684312099;4990.47600002;5001.524855138756;5051.848444546651;4700.694454860423;4855.223164293714;4855.393075865517;4882.9511704883025;4992.251162325662;4989.600831933437;5036.244563315514;5038.496150384969;5040.067587496306;5042.4201216860165;4960.87597810054;5031.949680503185;5034;5036.4208116066575;5041.14300568906;4760.809567617292;4798.1843086675;4839.322494850724;4849.321095046696;4964.826231081931;5198.818041368571;5200.97399513;5209.583233341324;5221.39953905302;5225.973870130625;5730.226419433407;5733.025385684444;5741.770329186827;5759.395263497315;5779;5581.6930068846195;5668.943310566883;5737.024705799982;5785.971070144665;5847.122931560258;5379.892402151935;5398.48714372138;5407.918881216785;5417.783288668448;5437.564994800407;5700.885982280414;5820.563457740686;5873.765049398062;5875.529957603381;5878.206442130343;5493.505584497414;5586.944130558723;5672.7730890763905;5681;5693.117566777156;5734.283214598176;5734.627249228787;5752.568557358215;5764.769409223668;5790.218320526759;5604.943950560442;5676.347220069662;5752.971235143881;5753.626014309057;5770.278715160605;5619.6347237430255;5678.3186017678145;5704.743286552032;5711.914321285184;5735.569832262597;4332.718373305725;4414.80133393998;4416.205083085011;4417.712848664826;4424.247877860771;3906.2187562487616;3946.960530394659;3967.1867267210155;3983.42240375144;3984.7210695251056;5454.509094181542;5479.589030822704;5497.697626630574;5503.504684578327;5513.283273174462;5788.18965344852;5792.507636850831;5799.3040835100055;5800.53595712342;5810.1865738796605;5379.112446446371;5439.700816455133;5446.21029950655;5507.972460137674;5517.751701173457;4913.680610760361;4926.679765815211;4931.679440836334;4947.950520494821;4967.552920237196;5897.115432685046;5922.851928701817;5923.466887980103;5931.169636250928;5947.078202878561;5590.944090559043;5697.6296540724725;5780.421957804186;5858.853528661817;5880.235569375954;5920.407959204045;5941.702914854326;5949.25634295713;5956.612820166675;5970.402959703995;5535.861603459945;5686.914696279477;5689.971550142222;5691.544676425793;5693.658380497183;5628.690422026828;5821.825345239649;5842;5862.618929769551;5905.616134951214;5664.575156863334;5679.630823996427;5681.4034526374135;5688.800891968761;5702.230198923258;5515.7242137893745;5591.9720401397735;5660.122680984454;5661.264035675501;5680.460356266148;5572.582056345709;5615.971920140537;5627.8593035174445;5651.491365777099;5668.234788303526;5566.721663916869;5588.748506317144;5625.662460252398;5648.152777083306;5653.745581448762;5376.704281264568;5511.283533140666;5529.640573362719;5530.889382212414;5538.141588053858 05:36:59 INFO - PROCESS | 31046 | |1;ext.html;509.149719967654;542.7611850785655;554.65611320981;560.8513743857877;573.3549756523911;32276.515852262204;41167.99999999996;41566.37650435238;41643.58356416435;41663;43132.56867431325;44051;44088.77955610218;44273;44499.3325100123;8807.823843523125;8964.596593153292;9006.639734410648;9032.68385606504;9035.322350823682;8586.957065214665;8673.479591224546;8700.216980471756;8705.042445331008;8723.825523489559;8758.124187581254;9135.725928222164;9146.405483643575;9157.358984871062;9165.908340916572;8972.685955991541;9056.637734490612;9057.728268151966;9064.36549441536;9070.591823367964;8919.955400223022;8948.821023579558;8969.461832290019;9046.321525885585;9085.909140908638;44354.55645443536;44551.108977820586;44974.32538511892;44996.77501612504;45130;3638.854445822164;3825.8087095645105;4099.893028882185;4236.5128010278595;4422.75674837887;32971.50542741861;33498.49752253718;33598.664013360045;34357.82821085879;34840.12899677503;4290.1591607164455;4354.433923589945;4361.672874534391;4372.038151606642;4475.306327519207;312545;315119;315697;316496;324063;47862;68465.3153468469;69690;70100.2989970104;70272.6486367565;62661;62985.68507157435;63012.36987630156;63208.36791632025;63357.36642633607;16547.669046619;16623.3350665972;16685;16685.24916378766;16687.332506699597;12720.427580758887;13039.217646941213;13046.282454465096;13074.803877941838;13551.932240338932;22568.54862902733;22867;22948.541029179323;23026;23092.884535577552;8596.527191004554;8754.956225218833;8757.080506546848;8778.166074222938;8855.601497932608;1005.7234260578399;1025.2259544044348;1066.4454483668449;1225.0628269373935;1225.8590262119792;31150.376992460024;31349.37301253962;31421.685783141875;31936;32103.197420064218;1100.070440477795;1116.0714285714403;1132.0377678972973;1136.6078702847503;1177.3465726521692;14315.92842035804;14474.493392731414;14478.782818257734;14637.85362146365;14770.556883293519;378146;378803;379676;381548;393662;51845.7407712959;52342.738286308326;52403.47596524062;52415.47584524106;52528;1483.1101339196396;1489.5605796289904;1501.7822415749656;1511.5767585076196;1625.1549194418835;28271.717282826907;30369.392612147192;30752;30925;31273.37453250968;49364.506354937424;49589;49800.25299620436;49914.25128623001;50073.24890126724;230438;231448;231543;231740;231825;32303.51544726784;32545.674543254263;35609.28781424409;35618.64381356153;36123.458148128324;46426.767866161805;46584;46977.530224697315;47482.28776568285;47729.761351193025;39819.40270895997;39889.60110398975;40607.943906616936;40695.1860962785;41000.589994099675;39624.603753963245;39723.40414893837;40038;40272.597274026884;40550.797246014765;38862.41706374463;39475;39581.80209098936;39965;40019;35150.648493515764;35355.82322088373;35736.821315894296;35746;35810.28379432449;26599.867000665647;27251.72748272492;27269.318267043484;27357.589636155077;28545 05:36:59 INFO - PROCESS | 31046 | |2;jquery.html;364.58073215801824;367.5240563470306;376.70805126027307;377.43950233902666;387.5988352055623;15902.125383103925;17666.911665441672;17996.280148794067;18356.35752748654;18943.905280473577;15823.762643560327;15860.603484912883;16059.116748578823;16563.50309490714;16639.50081497554;5086.389633244016;5209.843704688866;5244.921326180111;5246.055709972204;5246.213068039806;5148.871278218037;5204.739763011853;5455.890882182354;5754.568407369443;5773.682447465388;5273.472652734734;5494.697791621459;5737.082066869301;5749.59752817303;5750.568707346965;5175.585953123741;5383.084875571143;5425.3489581250105;5441.564674826024;5443.374011988612;5174.456682048369;5209.947900520984;5215.217717342391;5217.3217481727515;5232.502912223333;11701.765964680744;12096.516139354415;12199.39003049844;12213.633590992196;12228.755424891453;2108.630989576833;2285.2344464604375;2296.3684986628646;2306.042992158269;2416.8429052111733;10195.643152489702;10488.31825931312;10543.472826358651;11338.376389298584;14107.647308817259;1869.6354210928873;1885.5097674604701;1898.3166060218311;1927.0653732939513;1960.7941166177632;59610.10584841274;60382;60930.0860487093;61678;62552.68723656398;10812.243142979916;10935.125189984783;10980.505877235544;11001.394923279136;11010.834837477445;13621.318934053257;14453.49412770548;14547.19990400517;14632.780508292384;14645;7743.380529557622;7882.054153501616;7962.6416811243635;7985.361171106298;8012.839743205103;7689.077310722749;7746.612669366622;7781.80545486356;7829.138794732688;7845.9215407845195;4348.913021739548;4706.670533062653;4758.904821903612;4765.4996225395835;4774.355462012653;1851.287254407036;1968.7637483502072;1978.7130866024345;2062.257587268582;2083.6249475094323;964.1033838530234;973.776031512756;1034.4930983818026;1061.0079575596842;1090.9509072091776;15818.9209053954;16201.4329498467;16594.336226551044;16738.497845064667;16923.830761692472;1007.793402352516;1044.1698849414734;1058.777656692088;1065.9147268218524;1115.983260251097;9151.542422878829;9385.38994965325;9388.202002829836;9670.323077384515;9671.226301895831;340138;352633;566153;566746;572326;71551.2844871555;73422.63288683629;83728.58135709283;84340.15659843323;86058.56970715107;1169.590643274864;1201.3692811274152;1208.268997256647;1224.175977793082;1231.7228623559627;16283.104429256504;16452.670946581242;16454.83545164533;16499;16664.83335166633;36090;36561.45157822688;37093.25813483769;37633.435498467;37729.05677358088;46902.76548617235;47906;48762;49388.50611493839;52140;7755;7961.840763184588;8013.6794528218215;8057.677692892219;8170;11769.823452648046;12020.218685785396;12125.151239413157;12199.146059776085;12308.384580771104;9184.862227066733;9904.752381190528;9916.355436896578;10017.248706346907;10151.695449136538;10640.255182137176;10652.147828173573;10660.093892019266;10693.51879165455;11093.389863557582;10151;10208.438535880598;10266.897331026892;10333.121684656888;10455.686329409826;7810.336121429742;7839.960800195962;7844.529328240324;7854.921450785648;8016.1583033782945;8817.206451419403;9732.70801875945;9763.951180244054;9880.35777674449;9884.209263258777 05:36:59 INFO - PROCESS | 31046 | |3;mootools.html;1535.7619568966809;1559.6178936160638;1810.0857619233032;1895.1187697720557;1946.6301402733488;7776.4556481046275;7828.138904720477;7874.724384646539;7875.881861772071;8045.477043992151;8111.675532978688;8137.959310203455;8148.796280093001;8194.09864914859;8241.381896357767;2365.5387199496063;2380.1431484665595;2389.7849193572574;2392.1149174805346;2393.401649587603;2365.3849999000213;2377.8335516513853;2420.2376251480728;2420.9757902421015;2421.539907417585;2312.398776318161;2359.5162991586685;2363.8463499872455;2397.844140130886;2416.6012607919674;2396.5686176488225;2405.1341517053847;2431.2827715823787;2439.4633180700307;2439.7438268981678;2428.3200703802963;2432.7688869557364;2437.4759426723163;2441.279822452381;2448.791852692523;8085.231902969209;8110.716124935658;8118.837623247561;8131.9593402032615;8132.105468398471;4846.151923413424;4964.379452568429;4974.577160941324;4998.275250088716;5002.099622068026;3024.9395012099853;3064.9693503064905;3078.9692103079133;3099.4730895747775;3123.8281894495794;1045.6444808765057;1053.278504224601;1057.6298295596557;1075.9193060520413;1077.5258886090173;11377.374244416555;11473.139514536444;11481.655550333504;11481.885181148165;11498.54005839757;4306.82772689089;4319.97840010798;4378.7372757634;4403.075354175595;4412.470503539532;9343.626254949862;9369.390989585656;9369.953150234205;9371.625134994523;9381.484018378918;4825.517448255217;4833.130036593377;4844.515548445127;4845.442774080955;4850.854474365775;4400.097979914174;4414.404055452473;4457.866264012085;4459.7547134907245;4462.129884672523;3561.1809283864854;3627.9455808162897;3653.0319465341704;3658.1951970566433;3659.9817000914827;1051.542578978147;1079.1906070447164;1086.5165001574383;1117.7373317270435;1120.56298043763;976.2092704909046;1100.2683215661655;1145.9770804583861;1248.5318005747845;1368.2884899852022;7385.519941203805;7474.925250747532;7527.473076884675;7527.8494430111095;7538.283863033003;668.7458765669014;677.8849988037355;681.1349586025719;693.729445516249;805.9717909873126;5984.3417224105315;6075.2405949256345;6087.391260873877;6110.847228819315;6213.596116252519;9449.149576538144;9689.612415503441;10109.39343639384;10142.18862490999;10165.593376265015;9935.254855885838;9945.20438364929;9978.45118518474;10044.447555384379;10087.092161705481;7446.367058799954;7526.962365188139;7546.094468663686;7565;7869.724559640385;7707.499012564165;7735.110462296908;7868.449208555575;7877.054753429625;7877.803054923673;9073.810542657038;9127.08729127082;9144.177024067865;9196.540172991457;9261.53692315395;9260.629574816932;9356.719298421058;9463.38487998278;9484.478353690612;9503;7335.779926601997;7468.290512401313;7468.589227592534;7499.775006749806;7503.09962804467;7570.3943684504;7717.922820771721;7721.729739459092;7728.420368472274;7763.92236077632;6647.102641143577;7596.506227095221;7629.2752188542;7650.081990161217;7813.960930195312;7053.365197132282;7140.178879428932;7274.854502910018;7284.490085694162;7331.743388981574;7260.96369518149;7275.308845659654;7324.7070117196845;7353.889691654523;7357.77926662201;6353.745850166127;6410.61536307823;6431.389018043278;6435.388638079562;6436.034594810816;6761.188657361148;6906.8618627626165;6919.342662447059;6957.582545047313;6965.094537710065 05:36:59 INFO - PROCESS | 31046 | |4;prototype.html;373.3112407607963;375.3712531509722;380.75251086793565;381.721343419304;386.106164229808;6389.584676995992;6408.2310122785275;6486.545941784077;6505.21937367516;6584.934150658504;6249.281332646747;6364.777232796853;6375.362463753622;6401.231852177733;6423.967880160604;4922.3354847095725;4941.876453088675;4977.452480227172;4978.55193032627;4979.327790748239;4966.801327946896;4981.875453113683;4982.202847544394;4982.252662100677;4984.87537811554;4729.47975722672;4894.657373983822;4898.608111351101;4904.288878112671;4926.704397736147;4891.779869905863;4898.020395920812;4905.043516514281;4909.3126962225315;4921.876953076166;4304.74171549708;4305.311150215982;4306.80619372129;4311.245532031882;4314.784260786948;5928.644281343133;6129;6132.632042077445;6133.1413602095745;6138.815835524942;5722.284714410699;5733.226014488033;5733.512651424634;5734.483896449298;5744;6760.763373281911;6805.455563554904;6816.454683625348;6827.941669041306;6881.208661003999;4768.546988036131;4773.188557945123;4779.378680771478;4780.235162374038;4793.832215872462;6900.723971041152;7040.718371265143;7152.213256541776;7153.391961683211;7155.677994490208;4802.495737947535;4821.059893320768;4824.469308376076;4824.541668541483;4824.782884770194;4913.31213630092;4914.975425122851;4916.0905232532095;4917.87705307363;4925.581325587365;5583.860403489945;5641.464060914206;5663.8867222656145;5664.6034777566;5672.688002159838;6858.348456896587;6858.725650973905;6867.828304292432;6869;6871.312868713088;1650.5873531617096;1690.2985261116744;1721.173836558459;1752.8247175282625;1761.1722490429734;1133.0482394788417;1157.6469176900957;1175.6884425627215;1177.3171560494893;1188.3285943442102;6485.416312531895;6540.574862633914;6562.179727534059;6566.080748695186;6577.177852768404;6992.370686638125;7005.474589405815;7007;7008.773464643667;7023.683934222972;6410.358964103646;6520.282768895418;6521.315261897527;6528.314526974599;6547.803565893031;3773.188764415609;3774.471573979645;3782.678472329828;3805.238952209569;3805.980970095132;7157.2127066022695;7166.784996450115;7199.568025918357;7203.603801790951;7229.92770072303;7056.717731290691;7120.537165084356;7179.96410017957;7196.316349946851;7233.493655444068;7139.786666133516;7155.284471552803;7159.89260161098;7190.280971902768;7194.676239569232;6941.271166527644;6949.722011119498;6955.095837541087;6957.4086202671315;6957.826054348682;6803.353681400259;6808.863822723419;6859.17689877198;6992.30076992317;7016.7544135954995;7268.89096663561;7284.562926224444;7315.487915846053;7326.4138868889295;7331.890021649786;4909.729964851967;4932.753362331798;4939.604831613534;4942.135126352946;4943.826966056315;7027.7188912442925;7032.964835175791;7108.182559005781;7131.072960515307;7189.065421495172;6964.895526567004;6992.0910281663055;6994.965025175045;6996.300369962963;7013.123359580052;6970.268121847336;6974.721011159497;6982.476314276551;7012.7545535906;7044.506884518035;6646.667666616747;6760.1549806274215;6839.863202736017;6842.863142737217;6854.794356169323;6988.510804243858;6988.720451181895;7017.05269788572;7021.929780702128;7023.789286321418;6649.63427011519;6817.522773405814;6834.965825170842;6846.418054465426;6851.794446166623 05:36:59 INFO - PROCESS | 31046 | |5;yui.html;792.615581443;864.9221570058689;909.8271328447596;912.3841407050239;939.0562484702873;14277.286135693226;14390.568282951528;14412.639684007905;14423.990320677543;14455.710885782279;13275.933620331885;14266.928665356685;14375;14386.1368317901;14394.784078238808;879.7360791762462;883.2227639677108;891.61660485991;917.6650522559252;920.4569304110573;913.1690161952591;917.124146440148;923.7644400677817;925.5279807298259;928.8885333759958;952.0431965874321;953.213598781005;958.6884262614678;959.2661613865398;960.990390096097;943.5329511891589;946.2950102173855;946.4747065378712;948.426202147701;948.7580666929957;705.2770909817427;706.5195666946474;707.5188871567332;708.5642329967085;708.6598432752307;14341.28293585327;14359.78460323096;14376.281185940661;14391.064580802215;14398.136111833324;13265.403056862464;13401.195928244337;13504.729905401935;13523.120997135253;13760.587182384545;10026.799464010752;10353.948230258877;10423.895761042368;10451.477426128664;10534.367937923673;3793.241351729665;3802.201537677091;3803.790791506466;3811.313963486571;3821.254855303217;47727.28409073866;47916.76041619769;48527;49213.261801073015;49232.261516077284;10030.799384012425;10165.898341016644;10231.43727095017;10299.845502317472;10450.372977621368;18211.544711382056;18245.63508729818;18246.270149194148;18263.72604410935;18267.90866045688;7328.267173282629;7419.554826710415;7423.48035637511;8077.63650635711;8089.352851771844;4359.978200108979;4384.7369157850635;4440.866773996785;4491.281394976788;4565.429321334833;3070;3093.876244950222;3094.9535756963664;3096.9535456968165;3100.6589275179713;543.8531596469011;557.6793343827316;558.6368860240794;587.2160665511504;607.7022259093012;499.12652857499376;512.9897402051938;578.1385735254524;601.128363872378;653.2720953079079;8368.874466883002;8508.914910850812;8510.276626486695;8839.116088391109;9244.399114057565;517.1338008835186;591.5060924128315;604.9775878764873;662.9171353580803;716.8243780273866;3826.234753049401;4338.392625032498;4345.67407444443;4349.369341445473;4382.386465894777;58995;63735.36264637387;63797.68101159464;63857;63916;52250.738746306786;55089;55472.72263638656;55634.44365556374;55660;47818.5218147821;49609.75195124074;49741;49762.25356619581;50126.498735012916;8516.957415212884;8548.700795472128;8724.65101395937;8835.696811790323;9076.41003334781;37399.252014959005;38175.427368588935;38247;38730.6126938727;38796.80601596974;44520;44872;47913.76043119762;48482.27276590924;48774.02451951012;11983.940080299542;11994.460249288628;12063.51745930188;12217.877821221675;12454.128211025141;12072.27566345987;12179.939100304797;12554.874451255371;12620.17968832023;12727.363631818187;10781.946090269812;10946.179036572448;11069.225154239126;11112;11277.71805704864;11572.479238434458;11722.413879306172;11726.589569365031;11855.644330670093;12578.622641320775;11039.40234241298;11176.944115279372;11395.259308144945;11742.647720568397;12486.063545234325;9941.453220072965;9965.501724913871;10182.083612474913;10424.68725938223;10647.56257905173;9378.437293762396;9511.762205944906;9528.523573821143;9683.418994860049;9683.515824208902 05:36:59 INFO - PROCESS | 31046 | __end_tp_report 05:36:59 INFO - PROCESS | 31046 | __start_cc_report 05:36:59 INFO - PROCESS | 31046 | _x_x_mozilla_cycle_collect,302 05:36:59 INFO - PROCESS | 31046 | __end_cc_report 05:36:59 INFO - PROCESS | 31046 | __startTimestamp1460464619829__endTimestamp 05:36:59 INFO - PROCESS | 31046 | 05:36:59 INFO - PROCESS | 31046 | ------- Summary: start ------- 05:36:59 INFO - PROCESS | 31046 | Number of tests: 6 05:36:59 INFO - PROCESS | 31046 | 05:36:59 INFO - PROCESS | 31046 | [#0] dojo.html Cycles:165 Average:5352.83 Median:5538.14 stddev:576.06 (10.4%) stddev-sans-first:554.31 05:36:59 INFO - PROCESS | 31046 | Values: 3276.1 3296.7 3312.4 3329.9 3347.7 5313.2 5314.9 5342.2 5369.1 5370.1 5282.3 5353.0 5372.4 5378.6 5407.5 4900.3 4961.7 4990.5 5001.5 5051.8 4700.7 4855.2 4855.4 4883.0 4992.3 4989.6 5036.2 5038.5 5040.1 5042.4 4960.9 5031.9 5034.0 5036.4 5041.1 4760.8 4798.2 4839.3 4849.3 4964.8 5198.8 5201.0 5209.6 5221.4 5226.0 5730.2 5733.0 5741.8 5759.4 5779.0 5581.7 5668.9 5737.0 5786.0 5847.1 5379.9 5398.5 5407.9 5417.8 5437.6 5700.9 5820.6 5873.8 5875.5 5878.2 5493.5 5586.9 5672.8 5681.0 5693.1 5734.3 5734.6 5752.6 5764.8 5790.2 5604.9 5676.3 5753.0 5753.6 5770.3 5619.6 5678.3 5704.7 5711.9 5735.6 4332.7 4414.8 4416.2 4417.7 4424.2 3906.2 3947.0 3967.2 3983.4 3984.7 5454.5 5479.6 5497.7 5503.5 5513.3 5788.2 5792.5 5799.3 5800.5 5810.2 5379.1 5439.7 5446.2 5508.0 5517.8 4913.7 4926.7 4931.7 4948.0 4967.6 5897.1 5922.9 5923.5 5931.2 5947.1 5590.9 5697.6 5780.4 5858.9 5880.2 5920.4 5941.7 5949.3 5956.6 5970.4 5535.9 5686.9 5690.0 5691.5 5693.7 5628.7 5821.8 5842.0 5862.6 5905.6 5664.6 5679.6 5681.4 5688.8 5702.2 5515.7 5592.0 5660.1 5661.3 5680.5 5572.6 5616.0 5627.9 5651.5 5668.2 5566.7 5588.7 5625.7 5648.2 5653.7 5376.7 5511.3 5529.6 5530.9 5538.1 05:36:59 INFO - PROCESS | 31046 | 05:36:59 INFO - PROCESS | 31046 | [#1] ext.html Cycles:180 Average:49528.86 Median:39992.00 stddev:82874.49 (207.2%) stddev-sans-first:83025.25 05:36:59 INFO - PROCESS | 31046 | Values: 509.1 542.8 554.7 560.9 573.4 32276.5 41168.0 41566.4 41643.6 41663.0 43132.6 44051.0 44088.8 44273.0 44499.3 8807.8 8964.6 9006.6 9032.7 9035.3 8587.0 8673.5 8700.2 8705.0 8723.8 8758.1 9135.7 9146.4 9157.4 9165.9 8972.7 9056.6 9057.7 9064.4 9070.6 8920.0 8948.8 8969.5 9046.3 9085.9 44354.6 44551.1 44974.3 44996.8 45130.0 3638.9 3825.8 4099.9 4236.5 4422.8 32971.5 33498.5 33598.7 34357.8 34840.1 4290.2 4354.4 4361.7 4372.0 4475.3 312545.0 315119.0 315697.0 316496.0 324063.0 47862.0 68465.3 69690.0 70100.3 70272.6 62661.0 62985.7 63012.4 63208.4 63357.4 16547.7 16623.3 16685.0 16685.2 16687.3 12720.4 13039.2 13046.3 13074.8 13551.9 22568.5 22867.0 22948.5 23026.0 23092.9 8596.5 8755.0 8757.1 8778.2 8855.6 1005.7 1025.2 1066.4 1225.1 1225.9 31150.4 31349.4 31421.7 31936.0 32103.2 1100.1 1116.1 1132.0 1136.6 1177.3 14315.9 14474.5 14478.8 14637.9 14770.6 378146.0 378803.0 379676.0 381548.0 393662.0 51845.7 52342.7 52403.5 52415.5 52528.0 1483.1 1489.6 1501.8 1511.6 1625.2 28271.7 30369.4 30752.0 30925.0 31273.4 49364.5 49589.0 49800.3 49914.3 50073.2 230438.0 231448.0 231543.0 231740.0 231825.0 32303.5 32545.7 35609.3 35618.6 36123.5 46426.8 46584.0 46977.5 47482.3 47729.8 39819.4 39889.6 40607.9 40695.2 41000.6 39624.6 39723.4 40038.0 40272.6 40550.8 38862.4 39475.0 39581.8 39965.0 40019.0 35150.6 35355.8 35736.8 35746.0 35810.3 26599.9 27251.7 27269.3 27357.6 28545.0 05:36:59 INFO - PROCESS | 31046 | 05:36:59 INFO - PROCESS | 31046 | [#2] jquery.html Cycles:180 Average:26585.71 Median:18730.39 stddev:80697.98 (430.8%) stddev-sans-first:80900.34 05:36:59 INFO - PROCESS | 31046 | Values: 364.6 367.5 376.7 377.4 387.6 15902.1 17666.9 17996.3 18356.4 18943.9 15823.8 15860.6 16059.1 16563.5 16639.5 5086.4 5209.8 5244.9 5246.1 5246.2 5148.9 5204.7 5455.9 5754.6 5773.7 5273.5 5494.7 5737.1 5749.6 5750.6 5175.6 5383.1 5425.3 5441.6 5443.4 5174.5 5209.9 5215.2 5217.3 5232.5 11701.8 12096.5 12199.4 12213.6 12228.8 2108.6 2285.2 2296.4 2306.0 2416.8 10195.6 10488.3 10543.5 11338.4 14107.6 1869.6 1885.5 1898.3 1927.1 1960.8 59610.1 60382.0 60930.1 61678.0 62552.7 10812.2 10935.1 10980.5 11001.4 11010.8 13621.3 14453.5 14547.2 14632.8 14645.0 7743.4 7882.1 7962.6 7985.4 8012.8 7689.1 7746.6 7781.8 7829.1 7845.9 4348.9 4706.7 4758.9 4765.5 4774.4 1851.3 1968.8 1978.7 2062.3 2083.6 964.1 973.8 1034.5 1061.0 1091.0 15818.9 16201.4 16594.3 16738.5 16923.8 1007.8 1044.2 1058.8 1065.9 1116.0 9151.5 9385.4 9388.2 9670.3 9671.2 340138.0 352633.0 566153.0 566746.0 572326.0 71551.3 73422.6 83728.6 84340.2 86058.6 1169.6 1201.4 1208.3 1224.2 1231.7 16283.1 16452.7 16454.8 16499.0 16664.8 36090.0 36561.5 37093.3 37633.4 37729.1 46902.8 47906.0 48762.0 49388.5 52140.0 7755.0 7961.8 8013.7 8057.7 8170.0 11769.8 12020.2 12125.2 12199.1 12308.4 9184.9 9904.8 9916.4 10017.2 10151.7 10640.3 10652.1 10660.1 10693.5 11093.4 10151.0 10208.4 10266.9 10333.1 10455.7 7810.3 7840.0 7844.5 7854.9 8016.2 8817.2 9732.7 9764.0 9880.4 9884.2 05:36:59 INFO - PROCESS | 31046 | 05:36:59 INFO - PROCESS | 31046 | [#3] mootools.html Cycles:180 Average:5723.25 Median:6421.00 stddev:3027.69 (47.2%) stddev-sans-first:3019.83 05:36:59 INFO - PROCESS | 31046 | Values: 1535.8 1559.6 1810.1 1895.1 1946.6 7776.5 7828.1 7874.7 7875.9 8045.5 8111.7 8138.0 8148.8 8194.1 8241.4 2365.5 2380.1 2389.8 2392.1 2393.4 2365.4 2377.8 2420.2 2421.0 2421.5 2312.4 2359.5 2363.8 2397.8 2416.6 2396.6 2405.1 2431.3 2439.5 2439.7 2428.3 2432.8 2437.5 2441.3 2448.8 8085.2 8110.7 8118.8 8132.0 8132.1 4846.2 4964.4 4974.6 4998.3 5002.1 3024.9 3065.0 3079.0 3099.5 3123.8 1045.6 1053.3 1057.6 1075.9 1077.5 11377.4 11473.1 11481.7 11481.9 11498.5 4306.8 4320.0 4378.7 4403.1 4412.5 9343.6 9369.4 9370.0 9371.6 9381.5 4825.5 4833.1 4844.5 4845.4 4850.9 4400.1 4414.4 4457.9 4459.8 4462.1 3561.2 3627.9 3653.0 3658.2 3660.0 1051.5 1079.2 1086.5 1117.7 1120.6 976.2 1100.3 1146.0 1248.5 1368.3 7385.5 7474.9 7527.5 7527.8 7538.3 668.7 677.9 681.1 693.7 806.0 5984.3 6075.2 6087.4 6110.8 6213.6 9449.1 9689.6 10109.4 10142.2 10165.6 9935.3 9945.2 9978.5 10044.4 10087.1 7446.4 7527.0 7546.1 7565.0 7869.7 7707.5 7735.1 7868.4 7877.1 7877.8 9073.8 9127.1 9144.2 9196.5 9261.5 9260.6 9356.7 9463.4 9484.5 9503.0 7335.8 7468.3 7468.6 7499.8 7503.1 7570.4 7717.9 7721.7 7728.4 7763.9 6647.1 7596.5 7629.3 7650.1 7814.0 7053.4 7140.2 7274.9 7284.5 7331.7 7261.0 7275.3 7324.7 7353.9 7357.8 6353.7 6410.6 6431.4 6435.4 6436.0 6761.2 6906.9 6919.3 6957.6 6965.1 05:36:59 INFO - PROCESS | 31046 | 05:36:59 INFO - PROCESS | 31046 | [#4] prototype.html Cycles:180 Average:5722.50 Median:6512.75 stddev:1719.68 (26.4%) stddev-sans-first:1676.98 05:36:59 INFO - PROCESS | 31046 | Values: 373.3 375.4 380.8 381.7 386.1 6389.6 6408.2 6486.5 6505.2 6584.9 6249.3 6364.8 6375.4 6401.2 6424.0 4922.3 4941.9 4977.5 4978.6 4979.3 4966.8 4981.9 4982.2 4982.3 4984.9 4729.5 4894.7 4898.6 4904.3 4926.7 4891.8 4898.0 4905.0 4909.3 4921.9 4304.7 4305.3 4306.8 4311.2 4314.8 5928.6 6129.0 6132.6 6133.1 6138.8 5722.3 5733.2 5733.5 5734.5 5744.0 6760.8 6805.5 6816.5 6827.9 6881.2 4768.5 4773.2 4779.4 4780.2 4793.8 6900.7 7040.7 7152.2 7153.4 7155.7 4802.5 4821.1 4824.5 4824.5 4824.8 4913.3 4915.0 4916.1 4917.9 4925.6 5583.9 5641.5 5663.9 5664.6 5672.7 6858.3 6858.7 6867.8 6869.0 6871.3 1650.6 1690.3 1721.2 1752.8 1761.2 1133.0 1157.6 1175.7 1177.3 1188.3 6485.4 6540.6 6562.2 6566.1 6577.2 6992.4 7005.5 7007.0 7008.8 7023.7 6410.4 6520.3 6521.3 6528.3 6547.8 3773.2 3774.5 3782.7 3805.2 3806.0 7157.2 7166.8 7199.6 7203.6 7229.9 7056.7 7120.5 7180.0 7196.3 7233.5 7139.8 7155.3 7159.9 7190.3 7194.7 6941.3 6949.7 6955.1 6957.4 6957.8 6803.4 6808.9 6859.2 6992.3 7016.8 7268.9 7284.6 7315.5 7326.4 7331.9 4909.7 4932.8 4939.6 4942.1 4943.8 7027.7 7033.0 7108.2 7131.1 7189.1 6964.9 6992.1 6995.0 6996.3 7013.1 6970.3 6974.7 6982.5 7012.8 7044.5 6646.7 6760.2 6839.9 6842.9 6854.8 6988.5 6988.7 7017.1 7021.9 7023.8 6649.6 6817.5 6835.0 6846.4 6851.8 05:36:59 INFO - PROCESS | 31046 | 05:36:59 INFO - PROCESS | 31046 | [#5] yui.html Cycles:180 Average:14518.49 Median:47772.90 stddev:17007.49 (35.6%) stddev-sans-first:17023.97 05:36:59 INFO - PROCESS | 31046 | Values: 792.6 864.9 909.8 912.4 939.1 14277.3 14390.6 14412.6 14424.0 14455.7 13275.9 14266.9 14375.0 14386.1 14394.8 879.7 883.2 891.6 917.7 920.5 913.2 917.1 923.8 925.5 928.9 952.0 953.2 958.7 959.3 961.0 943.5 946.3 946.5 948.4 948.8 705.3 706.5 707.5 708.6 708.7 14341.3 14359.8 14376.3 14391.1 14398.1 13265.4 13401.2 13504.7 13523.1 13760.6 10026.8 10353.9 10423.9 10451.5 10534.4 3793.2 3802.2 3803.8 3811.3 3821.3 47727.3 47916.8 48527.0 49213.3 49232.3 10030.8 10165.9 10231.4 10299.8 10450.4 18211.5 18245.6 18246.3 18263.7 18267.9 7328.3 7419.6 7423.5 8077.6 8089.4 4360.0 4384.7 4440.9 4491.3 4565.4 3070.0 3093.9 3095.0 3097.0 3100.7 543.9 557.7 558.6 587.2 607.7 499.1 513.0 578.1 601.1 653.3 8368.9 8508.9 8510.3 8839.1 9244.4 517.1 591.5 605.0 662.9 716.8 3826.2 4338.4 4345.7 4349.4 4382.4 58995.0 63735.4 63797.7 63857.0 63916.0 52250.7 55089.0 55472.7 55634.4 55660.0 47818.5 49609.8 49741.0 49762.3 50126.5 8517.0 8548.7 8724.7 8835.7 9076.4 37399.3 38175.4 38247.0 38730.6 38796.8 44520.0 44872.0 47913.8 48482.3 48774.0 11983.9 11994.5 12063.5 12217.9 12454.1 12072.3 12179.9 12554.9 12620.2 12727.4 10781.9 10946.2 11069.2 11112.0 11277.7 11572.5 11722.4 11726.6 11855.6 12578.6 11039.4 11176.9 11395.3 11742.6 12486.1 9941.5 9965.5 10182.1 10424.7 10647.6 9378.4 9511.8 9528.5 9683.4 9683.5 05:36:59 INFO - PROCESS | 31046 | -------- Summary: end -------- 05:36:59 INFO - PROCESS | 31046 | 05:37:00 INFO - TEST-INFO | 31046: exit 0 05:37:00 INFO - TEST-OK | dromaeo_css | took 1109437ms 05:37:00 INFO - TEST-START | kraken 05:37:00 INFO - operating with platform_type : linux_ 05:37:00 INFO - Initialising browser for kraken test... 05:37:00 INFO - TEST-INFO | started process 31294 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPZNmYb/profile http://localhost:58429/getInfo.html) 05:37:04 INFO - PROCESS | 31294 | 05:37:04 INFO - PROCESS | 31294 | (process:31374): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:37:06 INFO - PROCESS | 31294 | __metrics Screen width/height:1600/1200 05:37:06 INFO - PROCESS | 31294 | colorDepth:24 05:37:06 INFO - PROCESS | 31294 | Browser inner width/height: 1024/697 05:37:06 INFO - PROCESS | 31294 | __metrics 05:37:06 INFO - PROCESS | 31294 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:37:07 INFO - TEST-INFO | 31294: exit 0 05:37:07 INFO - Browser initialized. 05:37:07 INFO - Running cycle 1/1 for kraken test... 05:37:07 INFO - TEST-INFO | started process 31422 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPZNmYb/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:08 INFO - PROCESS | 31422 | 05:37:08 INFO - PROCESS | 31422 | (process:31482): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:37:18 INFO - PROCESS | 31422 | RSS: Main: 138588160 05:37:18 INFO - PROCESS | 31422 | 05:37:21 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58429/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:21 INFO - PROCESS | 31422 | RSS: Main: 142577664 05:37:21 INFO - PROCESS | 31422 | 05:37:24 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58429/tests/kraken/driver.html?testName=audio-dft) 05:37:25 INFO - PROCESS | 31422 | RSS: Main: 143380480 05:37:25 INFO - PROCESS | 31422 | 05:37:28 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58429/tests/kraken/driver.html?testName=audio-fft) 05:37:28 INFO - PROCESS | 31422 | RSS: Main: 143847424 05:37:28 INFO - PROCESS | 31422 | 05:37:30 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58429/tests/kraken/driver.html?testName=audio-oscillator) 05:37:31 INFO - PROCESS | 31422 | RSS: Main: 143491072 05:37:31 INFO - PROCESS | 31422 | 05:37:33 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58429/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:33 INFO - PROCESS | 31422 | RSS: Main: 142995456 05:37:33 INFO - PROCESS | 31422 | 05:37:36 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58429/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:37 INFO - PROCESS | 31422 | RSS: Main: 143761408 05:37:37 INFO - PROCESS | 31422 | 05:37:40 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58429/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:41 INFO - PROCESS | 31422 | RSS: Main: 144269312 05:37:41 INFO - PROCESS | 31422 | 05:37:44 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58429/tests/kraken/driver.html?testName=json-parse-financial) 05:37:44 INFO - PROCESS | 31422 | RSS: Main: 143695872 05:37:44 INFO - PROCESS | 31422 | 05:37:46 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58429/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:46 INFO - PROCESS | 31422 | RSS: Main: 143007744 05:37:46 INFO - PROCESS | 31422 | 05:37:48 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58429/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:49 INFO - PROCESS | 31422 | RSS: Main: 144044032 05:37:49 INFO - PROCESS | 31422 | 05:37:51 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58429/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:37:51 INFO - PROCESS | 31422 | RSS: Main: 143777792 05:37:51 INFO - PROCESS | 31422 | 05:37:54 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:37:54 INFO - PROCESS | 31422 | RSS: Main: 144560128 05:37:54 INFO - PROCESS | 31422 | 05:37:57 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:37:57 INFO - PROCESS | 31422 | RSS: Main: 144416768 05:37:57 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | Cycle 1(1): loaded http://localhost:58429/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58429/tests/kraken/driver.html?testName=ai-astar) 05:37:59 INFO - PROCESS | 31422 | RSS: Main: 145076224 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | __start_tp_report 05:37:59 INFO - PROCESS | 31422 | _x_x_mozilla_page_load 05:37:59 INFO - PROCESS | 31422 | _x_x_mozilla_page_load_details 05:37:59 INFO - PROCESS | 31422 | |i|pagename|runs| 05:37:59 INFO - PROCESS | 31422 | |0;ai-astar;110;106;112;110;111;121;111;109;110;110 05:37:59 INFO - PROCESS | 31422 | |1;audio-beat-detection;154;129;149;172;131;157;155;130;166;127 05:37:59 INFO - PROCESS | 31422 | |2;audio-dft;162;162;162;162;161;161;159;161;164;164 05:37:59 INFO - PROCESS | 31422 | |3;audio-fft;73;76;73;153;73;76;72;74;148;77 05:37:59 INFO - PROCESS | 31422 | |4;audio-oscillator;95;96;150;94;96;96;139;95;95;133 05:37:59 INFO - PROCESS | 31422 | |5;imaging-gaussian-blur;110;112;109;109;110;110;110;112;109;110 05:37:59 INFO - PROCESS | 31422 | |6;imaging-darkroom;147;147;147;147;149;147;147;146;147;146 05:37:59 INFO - PROCESS | 31422 | |7;imaging-desaturate;97;96;97;97;96;96;98;96;96;96 05:37:59 INFO - PROCESS | 31422 | |8;json-parse-financial;59;58;58;62;58;58;57;58;56;56 05:37:59 INFO - PROCESS | 31422 | |9;json-stringify-tinderbox;63;63;62;63;64;64;63;63;63;65 05:37:59 INFO - PROCESS | 31422 | |10;stanford-crypto-aes;77;80;79;79;80;79;80;78;78;77 05:37:59 INFO - PROCESS | 31422 | |11;stanford-crypto-ccm;116;115;109;119;112;119;119;125;116;115 05:37:59 INFO - PROCESS | 31422 | |12;stanford-crypto-pbkdf2;136;136;138;127;125;135;135;134;134;140 05:37:59 INFO - PROCESS | 31422 | |13;stanford-crypto-sha256-iterative;64;67;63;65;65;67;64;66;65;65 05:37:59 INFO - PROCESS | 31422 | __end_tp_report 05:37:59 INFO - PROCESS | 31422 | __start_cc_report 05:37:59 INFO - PROCESS | 31422 | _x_x_mozilla_cycle_collect,703 05:37:59 INFO - PROCESS | 31422 | __end_cc_report 05:37:59 INFO - PROCESS | 31422 | __startTimestamp1460464679721__endTimestamp 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | ------- Summary: start ------- 05:37:59 INFO - PROCESS | 31422 | Number of tests: 14 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#0] ai-astar Cycles:10 Average:111.00 Median:110.50 stddev:3.86 (3.5%) stddev-sans-first:4.08 05:37:59 INFO - PROCESS | 31422 | Values: 110.0 106.0 112.0 110.0 111.0 121.0 111.0 109.0 110.0 110.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#1] audio-beat-detection Cycles:10 Average:147.00 Median:154.50 stddev:16.57 (10.7%) stddev-sans-first:17.38 05:37:59 INFO - PROCESS | 31422 | Values: 154.0 129.0 149.0 172.0 131.0 157.0 155.0 130.0 166.0 127.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.48 (0.9%) stddev-sans-first:1.56 05:37:59 INFO - PROCESS | 31422 | Values: 162.0 162.0 162.0 162.0 161.0 161.0 159.0 161.0 164.0 164.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#3] audio-fft Cycles:10 Average:89.50 Median:73.50 stddev:32.21 (43.8%) stddev-sans-first:33.61 05:37:59 INFO - PROCESS | 31422 | Values: 73.0 76.0 73.0 153.0 73.0 76.0 72.0 74.0 148.0 77.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.00 stddev:22.30 (23.5%) stddev-sans-first:23.08 05:37:59 INFO - PROCESS | 31422 | Values: 95.0 96.0 150.0 94.0 96.0 96.0 139.0 95.0 95.0 133.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#5] imaging-gaussian-blur Cycles:10 Average:110.10 Median:110.00 stddev:1.10 (1.0%) stddev-sans-first:1.17 05:37:59 INFO - PROCESS | 31422 | Values: 110.0 112.0 109.0 109.0 110.0 110.0 110.0 112.0 109.0 110.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.87 05:37:59 INFO - PROCESS | 31422 | Values: 147.0 147.0 147.0 147.0 149.0 147.0 147.0 146.0 147.0 146.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 05:37:59 INFO - PROCESS | 31422 | Values: 97.0 96.0 97.0 97.0 96.0 96.0 98.0 96.0 96.0 96.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#8] json-parse-financial Cycles:10 Average:58.00 Median:58.00 stddev:1.70 (2.9%) stddev-sans-first:1.76 05:37:59 INFO - PROCESS | 31422 | Values: 59.0 58.0 58.0 62.0 58.0 58.0 57.0 58.0 56.0 56.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 05:37:59 INFO - PROCESS | 31422 | Values: 63.0 63.0 62.0 63.0 64.0 64.0 63.0 63.0 63.0 65.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:79.00 stddev:1.16 (1.5%) stddev-sans-first:1.05 05:37:59 INFO - PROCESS | 31422 | Values: 77.0 80.0 79.0 79.0 80.0 79.0 80.0 78.0 78.0 77.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#11] stanford-crypto-ccm Cycles:10 Average:116.50 Median:117.50 stddev:4.38 (3.7%) stddev-sans-first:4.64 05:37:59 INFO - PROCESS | 31422 | Values: 116.0 115.0 109.0 119.0 112.0 119.0 119.0 125.0 116.0 115.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:134.00 Median:135.50 stddev:4.62 (3.4%) stddev-sans-first:4.84 05:37:59 INFO - PROCESS | 31422 | Values: 136.0 136.0 138.0 127.0 125.0 135.0 135.0 134.0 134.0 140.0 05:37:59 INFO - PROCESS | 31422 | 05:37:59 INFO - PROCESS | 31422 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.29 (2.0%) stddev-sans-first:1.30 05:37:59 INFO - PROCESS | 31422 | Values: 64.0 67.0 63.0 65.0 65.0 67.0 64.0 66.0 65.0 65.0 05:37:59 INFO - PROCESS | 31422 | -------- Summary: end -------- 05:37:59 INFO - PROCESS | 31422 | 05:38:00 INFO - TEST-INFO | 31422: exit 0 05:38:00 INFO - TEST-OK | kraken | took 60068ms 05:38:00 INFO - TEST-START | v8_7 05:38:00 INFO - operating with platform_type : linux_ 05:38:00 INFO - Initialising browser for v8_7 test... 05:38:00 INFO - TEST-INFO | started process 31709 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjDgoik/profile http://localhost:58429/getInfo.html) 05:38:05 INFO - PROCESS | 31709 | 05:38:05 INFO - PROCESS | 31709 | (process:31787): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:38:06 INFO - PROCESS | 31709 | __metrics Screen width/height:1600/1200 05:38:06 INFO - PROCESS | 31709 | colorDepth:24 05:38:06 INFO - PROCESS | 31709 | Browser inner width/height: 1024/697 05:38:06 INFO - PROCESS | 31709 | __metrics 05:38:06 INFO - PROCESS | 31709 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 05:38:07 INFO - TEST-INFO | 31709: exit 0 05:38:07 INFO - Browser initialized. 05:38:07 INFO - Running cycle 1/1 for v8_7 test... 05:38:07 INFO - TEST-INFO | started process 31835 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpjDgoik/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:38:08 INFO - PROCESS | 31835 | 05:38:08 INFO - PROCESS | 31835 | (process:31898): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:38:19 INFO - PROCESS | 31835 | RSS: Main: 138821632 05:38:19 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | Cycle 1(1): loaded http://localhost:58429/tests/v8_7/run.html (next: http://localhost:58429/tests/v8_7/run.html) 05:38:41 INFO - PROCESS | 31835 | RSS: Main: 143175680 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | __start_tp_report 05:38:41 INFO - PROCESS | 31835 | _x_x_mozilla_page_load 05:38:41 INFO - PROCESS | 31835 | _x_x_mozilla_page_load_details 05:38:41 INFO - PROCESS | 31835 | |i|pagename|runs| 05:38:41 INFO - PROCESS | 31835 | |0;Richards;169.9524133242692 05:38:41 INFO - PROCESS | 31835 | |1;DeltaBlue;167.16817118020728 05:38:41 INFO - PROCESS | 31835 | |2;Encrypt;280.97780275358247 05:38:41 INFO - PROCESS | 31835 | |3;Decrypt;5191.709844559586 05:38:41 INFO - PROCESS | 31835 | |4;RayTrace;937.207122774133 05:38:41 INFO - PROCESS | 31835 | |5;Earley;553.4034311012729 05:38:41 INFO - PROCESS | 31835 | |6;Boyer;10723.404255319148 05:38:41 INFO - PROCESS | 31835 | |7;RegExp;38433.96226415094 05:38:41 INFO - PROCESS | 31835 | |8;Splay;513.874614594039 05:38:41 INFO - PROCESS | 31835 | |9;NavierStokes;4822.115384615385 05:38:41 INFO - PROCESS | 31835 | __end_tp_report 05:38:41 INFO - PROCESS | 31835 | __startTimestamp1460464721842__endTimestamp 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | ------- Summary: start ------- 05:38:41 INFO - PROCESS | 31835 | Number of tests: 10 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#0] Richards Cycles:1 Average:169.95 Median:169.95 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 170.0 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#1] DeltaBlue Cycles:1 Average:167.17 Median:167.17 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 167.2 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 281.0 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 5191.7 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#4] RayTrace Cycles:1 Average:937.21 Median:937.21 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 937.2 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#5] Earley Cycles:1 Average:553.40 Median:553.40 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 553.4 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#6] Boyer Cycles:1 Average:10723.40 Median:10723.40 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 10723.4 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#7] RegExp Cycles:1 Average:38433.96 Median:38433.96 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 38434.0 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#8] Splay Cycles:1 Average:513.87 Median:513.87 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 513.9 05:38:41 INFO - PROCESS | 31835 | 05:38:41 INFO - PROCESS | 31835 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 05:38:41 INFO - PROCESS | 31835 | Values: 4822.1 05:38:41 INFO - PROCESS | 31835 | -------- Summary: end -------- 05:38:41 INFO - PROCESS | 31835 | 05:38:42 INFO - TEST-INFO | 31835: exit 0 05:38:42 INFO - TEST-OK | v8_7 | took 42190ms 05:38:42 INFO - SUITE-END | took 1211s 05:38:42 INFO - Completed test suite (00:20:11) 05:38:42 INFO - Working with test: dromaeo_css 05:38:42 INFO - Generating results file: dromaeo_css 05:38:42 INFO - Working with test: kraken 05:38:42 INFO - Generating results file: kraken 05:38:42 INFO - javascript benchmark 05:38:42 INFO - Working with test: v8_7 05:38:42 INFO - Generating results file: v8_7 05:38:42 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:38:42 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,53,43]] 05:38:42 INFO - process_Request line: dromaeo_css 7219.93 graph.html#tests=[[72,53,43]] 05:38:42 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:38:42 INFO - process_Request line: kraken 1487.40 graph.html#tests=[[232,53,43]] 05:38:42 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:38:43 INFO - process_Request line: v8_7 22172.96 graph.html#tests=[[230,53,43]] 05:38:43 INFO - RETURN: dromaeo_css: 7219.93 05:38:43 INFO - RETURN: kraken: 1487.40 05:38:43 INFO - RETURN: v8_7: 22172.96 05:38:43 INFO - javascript benchmark 05:38:43 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3276.1318250663576, 3296.6538513456085, 3312.403767321881, 3329.8501567429457, 3347.6652334766513, 5313.20301954707, 5314.867128321794, 5342.198670199472, 5369.087255166622, 5370.1407774756, 5282.260483532308, 5352.973235133829, 5372.355317361922, 5378.569714422846, 5407.540359069474, 4900.264960255954, 4961.652684312099, 4990.47600002, 5001.524855138756, 5051.848444546651, 4700.694454860423, 4855.223164293714, 4855.393075865517, 4882.9511704883025, 4992.251162325662, 4989.600831933437, 5036.244563315514, 5038.496150384969, 5040.067587496306, 5042.4201216860165, 4960.87597810054, 5031.949680503185, 5034.0, 5036.4208116066575, 5041.14300568906, 4760.809567617292, 4798.1843086675, 4839.322494850724, 4849.321095046696, 4964.826231081931, 5198.818041368571, 5200.97399513, 5209.583233341324, 5221.39953905302, 5225.973870130625, 5730.226419433407, 5733.025385684444, 5741.770329186827, 5759.395263497315, 5779.0, 5581.6930068846195, 5668.943310566883, 5737.024705799982, 5785.971070144665, 5847.122931560258, 5379.892402151935, 5398.48714372138, 5407.918881216785, 5417.783288668448, 5437.564994800407, 5700.885982280414, 5820.563457740686, 5873.765049398062, 5875.529957603381, 5878.206442130343, 5493.505584497414, 5586.944130558723, 5672.7730890763905, 5681.0, 5693.117566777156, 5734.283214598176, 5734.627249228787, 5752.568557358215, 5764.769409223668, 5790.218320526759, 5604.943950560442, 5676.347220069662, 5752.971235143881, 5753.626014309057, 5770.278715160605, 5619.6347237430255, 5678.3186017678145, 5704.743286552032, 5711.914321285184, 5735.569832262597, 4332.718373305725, 4414.80133393998, 4416.205083085011, 4417.712848664826, 4424.247877860771, 3906.2187562487616, 3946.960530394659, 3967.1867267210155, 3983.42240375144, 3984.7210695251056, 5454.509094181542, 5479.589030822704, 5497.697626630574, 5503.504684578327, 5513.283273174462, 5788.18965344852, 5792.507636850831, 5799.3040835100055, 5800.53595712342, 5810.1865738796605, 5379.112446446371, 5439.700816455133, 5446.21029950655, 5507.972460137674, 5517.751701173457, 4913.680610760361, 4926.679765815211, 4931.679440836334, 4947.950520494821, 4967.552920237196, 5897.115432685046, 5922.851928701817, 5923.466887980103, 5931.169636250928, 5947.078202878561, 5590.944090559043, 5697.6296540724725, 5780.421957804186, 5858.853528661817, 5880.235569375954, 5920.407959204045, 5941.702914854326, 5949.25634295713, 5956.612820166675, 5970.402959703995, 5535.861603459945, 5686.914696279477, 5689.971550142222, 5691.544676425793, 5693.658380497183, 5628.690422026828, 5821.825345239649, 5842.0, 5862.618929769551, 5905.616134951214, 5664.575156863334, 5679.630823996427, 5681.4034526374135, 5688.800891968761, 5702.230198923258, 5515.7242137893745, 5591.9720401397735, 5660.122680984454, 5661.264035675501, 5680.460356266148, 5572.582056345709, 5615.971920140537, 5627.8593035174445, 5651.491365777099, 5668.234788303526, 5566.721663916869, 5588.748506317144, 5625.662460252398, 5648.152777083306, 5653.745581448762, 5376.704281264568, 5511.283533140666, 5529.640573362719, 5530.889382212414, 5538.141588053858], "unit": "score", "name": "dojo.html", "value": 5316.828000383491}, {"lowerIsBetter": false, "replicates": [509.149719967654, 542.7611850785655, 554.65611320981, 560.8513743857877, 573.3549756523911, 32276.515852262204, 41167.99999999996, 41566.37650435238, 41643.58356416435, 41663.0, 43132.56867431325, 44051.0, 44088.77955610218, 44273.0, 44499.3325100123, 8807.823843523125, 8964.596593153292, 9006.639734410648, 9032.68385606504, 9035.322350823682, 8586.957065214665, 8673.479591224546, 8700.216980471756, 8705.042445331008, 8723.825523489559, 8758.124187581254, 9135.725928222164, 9146.405483643575, 9157.358984871062, 9165.908340916572, 8972.685955991541, 9056.637734490612, 9057.728268151966, 9064.36549441536, 9070.591823367964, 8919.955400223022, 8948.821023579558, 8969.461832290019, 9046.321525885585, 9085.909140908638, 44354.55645443536, 44551.108977820586, 44974.32538511892, 44996.77501612504, 45130.0, 3638.854445822164, 3825.8087095645105, 4099.893028882185, 4236.5128010278595, 4422.75674837887, 32971.50542741861, 33498.49752253718, 33598.664013360045, 34357.82821085879, 34840.12899677503, 4290.1591607164455, 4354.433923589945, 4361.672874534391, 4372.038151606642, 4475.306327519207, 312545.0, 315119.0, 315697.0, 316496.0, 324063.0, 47862.0, 68465.3153468469, 69690.0, 70100.2989970104, 70272.6486367565, 62661.0, 62985.68507157435, 63012.36987630156, 63208.36791632025, 63357.36642633607, 16547.669046619, 16623.3350665972, 16685.0, 16685.24916378766, 16687.332506699597, 12720.427580758887, 13039.217646941213, 13046.282454465096, 13074.803877941838, 13551.932240338932, 22568.54862902733, 22867.0, 22948.541029179323, 23026.0, 23092.884535577552, 8596.527191004554, 8754.956225218833, 8757.080506546848, 8778.166074222938, 8855.601497932608, 1005.7234260578399, 1025.2259544044348, 1066.4454483668449, 1225.0628269373935, 1225.8590262119792, 31150.376992460024, 31349.37301253962, 31421.685783141875, 31936.0, 32103.197420064218, 1100.070440477795, 1116.0714285714403, 1132.0377678972973, 1136.6078702847503, 1177.3465726521692, 14315.92842035804, 14474.493392731414, 14478.782818257734, 14637.85362146365, 14770.556883293519, 378146.0, 378803.0, 379676.0, 381548.0, 393662.0, 51845.7407712959, 52342.738286308326, 52403.47596524062, 52415.47584524106, 52528.0, 1483.1101339196396, 1489.5605796289904, 1501.7822415749656, 1511.5767585076196, 1625.1549194418835, 28271.717282826907, 30369.392612147192, 30752.0, 30925.0, 31273.37453250968, 49364.506354937424, 49589.0, 49800.25299620436, 49914.25128623001, 50073.24890126724, 230438.0, 231448.0, 231543.0, 231740.0, 231825.0, 32303.51544726784, 32545.674543254263, 35609.28781424409, 35618.64381356153, 36123.458148128324, 46426.767866161805, 46584.0, 46977.530224697315, 47482.28776568285, 47729.761351193025, 39819.40270895997, 39889.60110398975, 40607.943906616936, 40695.1860962785, 41000.589994099675, 39624.603753963245, 39723.40414893837, 40038.0, 40272.597274026884, 40550.797246014765, 38862.41706374463, 39475.0, 39581.80209098936, 39965.0, 40019.0, 35150.648493515764, 35355.82322088373, 35736.821315894296, 35746.0, 35810.28379432449, 26599.867000665647, 27251.72748272492, 27269.318267043484, 27357.589636155077, 28545.0], "unit": "score", "name": "ext.html", "value": 19847.83766644012}, {"lowerIsBetter": false, "replicates": [364.58073215801824, 367.5240563470306, 376.70805126027307, 377.43950233902666, 387.5988352055623, 15902.125383103925, 17666.911665441672, 17996.280148794067, 18356.35752748654, 18943.905280473577, 15823.762643560327, 15860.603484912883, 16059.116748578823, 16563.50309490714, 16639.50081497554, 5086.389633244016, 5209.843704688866, 5244.921326180111, 5246.055709972204, 5246.213068039806, 5148.871278218037, 5204.739763011853, 5455.890882182354, 5754.568407369443, 5773.682447465388, 5273.472652734734, 5494.697791621459, 5737.082066869301, 5749.59752817303, 5750.568707346965, 5175.585953123741, 5383.084875571143, 5425.3489581250105, 5441.564674826024, 5443.374011988612, 5174.456682048369, 5209.947900520984, 5215.217717342391, 5217.3217481727515, 5232.502912223333, 11701.765964680744, 12096.516139354415, 12199.39003049844, 12213.633590992196, 12228.755424891453, 2108.630989576833, 2285.2344464604375, 2296.3684986628646, 2306.042992158269, 2416.8429052111733, 10195.643152489702, 10488.31825931312, 10543.472826358651, 11338.376389298584, 14107.647308817259, 1869.6354210928873, 1885.5097674604701, 1898.3166060218311, 1927.0653732939513, 1960.7941166177632, 59610.10584841274, 60382.0, 60930.0860487093, 61678.0, 62552.68723656398, 10812.243142979916, 10935.125189984783, 10980.505877235544, 11001.394923279136, 11010.834837477445, 13621.318934053257, 14453.49412770548, 14547.19990400517, 14632.780508292384, 14645.0, 7743.380529557622, 7882.054153501616, 7962.6416811243635, 7985.361171106298, 8012.839743205103, 7689.077310722749, 7746.612669366622, 7781.80545486356, 7829.138794732688, 7845.9215407845195, 4348.913021739548, 4706.670533062653, 4758.904821903612, 4765.4996225395835, 4774.355462012653, 1851.287254407036, 1968.7637483502072, 1978.7130866024345, 2062.257587268582, 2083.6249475094323, 964.1033838530234, 973.776031512756, 1034.4930983818026, 1061.0079575596842, 1090.9509072091776, 15818.9209053954, 16201.4329498467, 16594.336226551044, 16738.497845064667, 16923.830761692472, 1007.793402352516, 1044.1698849414734, 1058.777656692088, 1065.9147268218524, 1115.983260251097, 9151.542422878829, 9385.38994965325, 9388.202002829836, 9670.323077384515, 9671.226301895831, 340138.0, 352633.0, 566153.0, 566746.0, 572326.0, 71551.2844871555, 73422.63288683629, 83728.58135709283, 84340.15659843323, 86058.56970715107, 1169.590643274864, 1201.3692811274152, 1208.268997256647, 1224.175977793082, 1231.7228623559627, 16283.104429256504, 16452.670946581242, 16454.83545164533, 16499.0, 16664.83335166633, 36090.0, 36561.45157822688, 37093.25813483769, 37633.435498467, 37729.05677358088, 46902.76548617235, 47906.0, 48762.0, 49388.50611493839, 52140.0, 7755.0, 7961.840763184588, 8013.6794528218215, 8057.677692892219, 8170.0, 11769.823452648046, 12020.218685785396, 12125.151239413157, 12199.146059776085, 12308.384580771104, 9184.862227066733, 9904.752381190528, 9916.355436896578, 10017.248706346907, 10151.695449136538, 10640.255182137176, 10652.147828173573, 10660.093892019266, 10693.51879165455, 11093.389863557582, 10151.0, 10208.438535880598, 10266.897331026892, 10333.121684656888, 10455.686329409826, 7810.336121429742, 7839.960800195962, 7844.529328240324, 7854.921450785648, 8016.1583033782945, 8817.206451419403, 9732.70801875945, 9763.951180244054, 9880.35777674449, 9884.209263258777], "unit": "score", "name": "jquery.html", "value": 8505.170232697123}, {"lowerIsBetter": false, "replicates": [1535.7619568966809, 1559.6178936160638, 1810.0857619233032, 1895.1187697720557, 1946.6301402733488, 7776.4556481046275, 7828.138904720477, 7874.724384646539, 7875.881861772071, 8045.477043992151, 8111.675532978688, 8137.959310203455, 8148.796280093001, 8194.09864914859, 8241.381896357767, 2365.5387199496063, 2380.1431484665595, 2389.7849193572574, 2392.1149174805346, 2393.401649587603, 2365.3849999000213, 2377.8335516513853, 2420.2376251480728, 2420.9757902421015, 2421.539907417585, 2312.398776318161, 2359.5162991586685, 2363.8463499872455, 2397.844140130886, 2416.6012607919674, 2396.5686176488225, 2405.1341517053847, 2431.2827715823787, 2439.4633180700307, 2439.7438268981678, 2428.3200703802963, 2432.7688869557364, 2437.4759426723163, 2441.279822452381, 2448.791852692523, 8085.231902969209, 8110.716124935658, 8118.837623247561, 8131.9593402032615, 8132.105468398471, 4846.151923413424, 4964.379452568429, 4974.577160941324, 4998.275250088716, 5002.099622068026, 3024.9395012099853, 3064.9693503064905, 3078.9692103079133, 3099.4730895747775, 3123.8281894495794, 1045.6444808765057, 1053.278504224601, 1057.6298295596557, 1075.9193060520413, 1077.5258886090173, 11377.374244416555, 11473.139514536444, 11481.655550333504, 11481.885181148165, 11498.54005839757, 4306.82772689089, 4319.97840010798, 4378.7372757634, 4403.075354175595, 4412.470503539532, 9343.626254949862, 9369.390989585656, 9369.953150234205, 9371.625134994523, 9381.484018378918, 4825.517448255217, 4833.130036593377, 4844.515548445127, 4845.442774080955, 4850.854474365775, 4400.097979914174, 4414.404055452473, 4457.866264012085, 4459.7547134907245, 4462.129884672523, 3561.1809283864854, 3627.9455808162897, 3653.0319465341704, 3658.1951970566433, 3659.9817000914827, 1051.542578978147, 1079.1906070447164, 1086.5165001574383, 1117.7373317270435, 1120.56298043763, 976.2092704909046, 1100.2683215661655, 1145.9770804583861, 1248.5318005747845, 1368.2884899852022, 7385.519941203805, 7474.925250747532, 7527.473076884675, 7527.8494430111095, 7538.283863033003, 668.7458765669014, 677.8849988037355, 681.1349586025719, 693.729445516249, 805.9717909873126, 5984.3417224105315, 6075.2405949256345, 6087.391260873877, 6110.847228819315, 6213.596116252519, 9449.149576538144, 9689.612415503441, 10109.39343639384, 10142.18862490999, 10165.593376265015, 9935.254855885838, 9945.20438364929, 9978.45118518474, 10044.447555384379, 10087.092161705481, 7446.367058799954, 7526.962365188139, 7546.094468663686, 7565.0, 7869.724559640385, 7707.499012564165, 7735.110462296908, 7868.449208555575, 7877.054753429625, 7877.803054923673, 9073.810542657038, 9127.08729127082, 9144.177024067865, 9196.540172991457, 9261.53692315395, 9260.629574816932, 9356.719298421058, 9463.38487998278, 9484.478353690612, 9503.0, 7335.779926601997, 7468.290512401313, 7468.589227592534, 7499.775006749806, 7503.09962804467, 7570.3943684504, 7717.922820771721, 7721.729739459092, 7728.420368472274, 7763.92236077632, 6647.102641143577, 7596.506227095221, 7629.2752188542, 7650.081990161217, 7813.960930195312, 7053.365197132282, 7140.178879428932, 7274.854502910018, 7284.490085694162, 7331.743388981574, 7260.96369518149, 7275.308845659654, 7324.7070117196845, 7353.889691654523, 7357.77926662201, 6353.745850166127, 6410.61536307823, 6431.389018043278, 6435.388638079562, 6436.034594810816, 6761.188657361148, 6906.8618627626165, 6919.342662447059, 6957.582545047313, 6965.094537710065], "unit": "score", "name": "mootools.html", "value": 4628.959466735357}, {"lowerIsBetter": false, "replicates": [373.3112407607963, 375.3712531509722, 380.75251086793565, 381.721343419304, 386.106164229808, 6389.584676995992, 6408.2310122785275, 6486.545941784077, 6505.21937367516, 6584.934150658504, 6249.281332646747, 6364.777232796853, 6375.362463753622, 6401.231852177733, 6423.967880160604, 4922.3354847095725, 4941.876453088675, 4977.452480227172, 4978.55193032627, 4979.327790748239, 4966.801327946896, 4981.875453113683, 4982.202847544394, 4982.252662100677, 4984.87537811554, 4729.47975722672, 4894.657373983822, 4898.608111351101, 4904.288878112671, 4926.704397736147, 4891.779869905863, 4898.020395920812, 4905.043516514281, 4909.3126962225315, 4921.876953076166, 4304.74171549708, 4305.311150215982, 4306.80619372129, 4311.245532031882, 4314.784260786948, 5928.644281343133, 6129.0, 6132.632042077445, 6133.1413602095745, 6138.815835524942, 5722.284714410699, 5733.226014488033, 5733.512651424634, 5734.483896449298, 5744.0, 6760.763373281911, 6805.455563554904, 6816.454683625348, 6827.941669041306, 6881.208661003999, 4768.546988036131, 4773.188557945123, 4779.378680771478, 4780.235162374038, 4793.832215872462, 6900.723971041152, 7040.718371265143, 7152.213256541776, 7153.391961683211, 7155.677994490208, 4802.495737947535, 4821.059893320768, 4824.469308376076, 4824.541668541483, 4824.782884770194, 4913.31213630092, 4914.975425122851, 4916.0905232532095, 4917.87705307363, 4925.581325587365, 5583.860403489945, 5641.464060914206, 5663.8867222656145, 5664.6034777566, 5672.688002159838, 6858.348456896587, 6858.725650973905, 6867.828304292432, 6869.0, 6871.312868713088, 1650.5873531617096, 1690.2985261116744, 1721.173836558459, 1752.8247175282625, 1761.1722490429734, 1133.0482394788417, 1157.6469176900957, 1175.6884425627215, 1177.3171560494893, 1188.3285943442102, 6485.416312531895, 6540.574862633914, 6562.179727534059, 6566.080748695186, 6577.177852768404, 6992.370686638125, 7005.474589405815, 7007.0, 7008.773464643667, 7023.683934222972, 6410.358964103646, 6520.282768895418, 6521.315261897527, 6528.314526974599, 6547.803565893031, 3773.188764415609, 3774.471573979645, 3782.678472329828, 3805.238952209569, 3805.980970095132, 7157.2127066022695, 7166.784996450115, 7199.568025918357, 7203.603801790951, 7229.92770072303, 7056.717731290691, 7120.537165084356, 7179.96410017957, 7196.316349946851, 7233.493655444068, 7139.786666133516, 7155.284471552803, 7159.89260161098, 7190.280971902768, 7194.676239569232, 6941.271166527644, 6949.722011119498, 6955.095837541087, 6957.4086202671315, 6957.826054348682, 6803.353681400259, 6808.863822723419, 6859.17689877198, 6992.30076992317, 7016.7544135954995, 7268.89096663561, 7284.562926224444, 7315.487915846053, 7326.4138868889295, 7331.890021649786, 4909.729964851967, 4932.753362331798, 4939.604831613534, 4942.135126352946, 4943.826966056315, 7027.7188912442925, 7032.964835175791, 7108.182559005781, 7131.072960515307, 7189.065421495172, 6964.895526567004, 6992.0910281663055, 6994.965025175045, 6996.300369962963, 7013.123359580052, 6970.268121847336, 6974.721011159497, 6982.476314276551, 7012.7545535906, 7044.506884518035, 6646.667666616747, 6760.1549806274215, 6839.863202736017, 6842.863142737217, 6854.794356169323, 6988.510804243858, 6988.720451181895, 7017.05269788572, 7021.929780702128, 7023.789286321418, 6649.63427011519, 6817.522773405814, 6834.965825170842, 6846.418054465426, 6851.794446166623], "unit": "score", "name": "prototype.html", "value": 5167.915648470517}, {"lowerIsBetter": false, "replicates": [792.615581443, 864.9221570058689, 909.8271328447596, 912.3841407050239, 939.0562484702873, 14277.286135693226, 14390.568282951528, 14412.639684007905, 14423.990320677543, 14455.710885782279, 13275.933620331885, 14266.928665356685, 14375.0, 14386.1368317901, 14394.784078238808, 879.7360791762462, 883.2227639677108, 891.61660485991, 917.6650522559252, 920.4569304110573, 913.1690161952591, 917.124146440148, 923.7644400677817, 925.5279807298259, 928.8885333759958, 952.0431965874321, 953.213598781005, 958.6884262614678, 959.2661613865398, 960.990390096097, 943.5329511891589, 946.2950102173855, 946.4747065378712, 948.426202147701, 948.7580666929957, 705.2770909817427, 706.5195666946474, 707.5188871567332, 708.5642329967085, 708.6598432752307, 14341.28293585327, 14359.78460323096, 14376.281185940661, 14391.064580802215, 14398.136111833324, 13265.403056862464, 13401.195928244337, 13504.729905401935, 13523.120997135253, 13760.587182384545, 10026.799464010752, 10353.948230258877, 10423.895761042368, 10451.477426128664, 10534.367937923673, 3793.241351729665, 3802.201537677091, 3803.790791506466, 3811.313963486571, 3821.254855303217, 47727.28409073866, 47916.76041619769, 48527.0, 49213.261801073015, 49232.261516077284, 10030.799384012425, 10165.898341016644, 10231.43727095017, 10299.845502317472, 10450.372977621368, 18211.544711382056, 18245.63508729818, 18246.270149194148, 18263.72604410935, 18267.90866045688, 7328.267173282629, 7419.554826710415, 7423.48035637511, 8077.63650635711, 8089.352851771844, 4359.978200108979, 4384.7369157850635, 4440.866773996785, 4491.281394976788, 4565.429321334833, 3070.0, 3093.876244950222, 3094.9535756963664, 3096.9535456968165, 3100.6589275179713, 543.8531596469011, 557.6793343827316, 558.6368860240794, 587.2160665511504, 607.7022259093012, 499.12652857499376, 512.9897402051938, 578.1385735254524, 601.128363872378, 653.2720953079079, 8368.874466883002, 8508.914910850812, 8510.276626486695, 8839.116088391109, 9244.399114057565, 517.1338008835186, 591.5060924128315, 604.9775878764873, 662.9171353580803, 716.8243780273866, 3826.234753049401, 4338.392625032498, 4345.67407444443, 4349.369341445473, 4382.386465894777, 58995.0, 63735.36264637387, 63797.68101159464, 63857.0, 63916.0, 52250.738746306786, 55089.0, 55472.72263638656, 55634.44365556374, 55660.0, 47818.5218147821, 49609.75195124074, 49741.0, 49762.25356619581, 50126.498735012916, 8516.957415212884, 8548.700795472128, 8724.65101395937, 8835.696811790323, 9076.41003334781, 37399.252014959005, 38175.427368588935, 38247.0, 38730.6126938727, 38796.80601596974, 44520.0, 44872.0, 47913.76043119762, 48482.27276590924, 48774.02451951012, 11983.940080299542, 11994.460249288628, 12063.51745930188, 12217.877821221675, 12454.128211025141, 12072.27566345987, 12179.939100304797, 12554.874451255371, 12620.17968832023, 12727.363631818187, 10781.946090269812, 10946.179036572448, 11069.225154239126, 11112.0, 11277.71805704864, 11572.479238434458, 11722.413879306172, 11726.589569365031, 11855.644330670093, 12578.622641320775, 11039.40234241298, 11176.944115279372, 11395.259308144945, 11742.647720568397, 12486.063545234325, 9941.453220072965, 9965.501724913871, 10182.083612474913, 10424.68725938223, 10647.56257905173, 9378.437293762396, 9511.762205944906, 9528.523573821143, 9683.418994860049, 9683.515824208902], "unit": "score", "name": "yui.html", "value": 6596.494253835758}], "name": "dromaeo_css", "value": 7219.930779078279}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 112.0, 110.0, 111.0, 121.0, 111.0, 109.0, 110.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 149.0, 172.0, 131.0, 157.0, 155.0, 130.0, 166.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 147.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 162.0, 162.0, 161.0, 161.0, 159.0, 161.0, 164.0, 164.0], "unit": "score", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 73.0, 153.0, 73.0, 76.0, 72.0, 74.0, 148.0, 77.0], "unit": "score", "name": "audio-fft", "value": 89.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 150.0, 94.0, 96.0, 96.0, 139.0, 95.0, 95.0, 133.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 109.0, 109.0, 110.0, 110.0, 110.0, 112.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 149.0, 147.0, 147.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [59.0, 58.0, 58.0, 62.0, 58.0, 58.0, 57.0, 58.0, 56.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 58.0}, {"lowerIsBetter": true, "replicates": [63.0, 63.0, 62.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 63.3}, {"lowerIsBetter": true, "replicates": [77.0, 80.0, 79.0, 79.0, 80.0, 79.0, 80.0, 78.0, 78.0, 77.0], "unit": "score", "name": "stanford-crypto-aes", "value": 78.7}, {"lowerIsBetter": true, "replicates": [116.0, 115.0, 109.0, 119.0, 112.0, 119.0, 119.0, 125.0, 116.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.5}, {"lowerIsBetter": true, "replicates": [136.0, 136.0, 138.0, 127.0, 125.0, 135.0, 135.0, 134.0, 134.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 134.0}, {"lowerIsBetter": true, "replicates": [64.0, 67.0, 63.0, 65.0, 65.0, 67.0, 64.0, 66.0, 65.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1487.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.9524133242692], "unit": "score", "name": "Richards", "value": 207.7169679999999}, {"lowerIsBetter": false, "replicates": [167.16817118020728], "unit": "score", "name": "DeltaBlue", "value": 395.5178759999999}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [937.207122774133], "unit": "score", "name": "RayTrace", "value": 789.568263}, {"lowerIsBetter": false, "replicates": [553.4034311012729], "unit": "score", "name": "Earley", "value": 1204.2986409999994}, {"lowerIsBetter": false, "replicates": [10723.404255319148], "unit": "score", "name": "Boyer", "value": 62.1503194444445}, {"lowerIsBetter": false, "replicates": [38433.96226415094], "unit": "score", "name": "RegExp", "value": 23.702604320078553}, {"lowerIsBetter": false, "replicates": [513.874614594039], "unit": "score", "name": "Splay", "value": 158.58148599999993}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22172.96105513738}]} 05:38:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,53,43]]", "result": "22172.96"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,53,43]]", "result": "1487.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,53,43]]", "result": "7219.93"}}} 05:38:43 INFO - Return code: 0 05:38:43 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:38:43 INFO - # TBPL SUCCESS # 05:38:43 INFO - Running post-action listener: _resource_record_post_action 05:38:43 INFO - Running post-run listener: _resource_record_post_run 05:38:44 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 4096; Write bytes: 468770816; Read time: 16; Write time: 727800 05:38:44 INFO - install - Wall time: 13s; CPU: 16.0%; Read bytes: 0; Write bytes: 230940672; Read time: 0; Write time: 515616 05:38:44 INFO - run-tests - Wall time: 1213s; CPU: 13.0%; Read bytes: 4096; Write bytes: 233435136; Read time: 16; Write time: 211728 05:38:44 INFO - Running post-run listener: _upload_blobber_files 05:38:44 INFO - Blob upload gear active. 05:38:44 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:38:44 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:38:44 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-Beta', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:38:44 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-Beta -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:38:44 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:38:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:38:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:45 INFO - (blobuploader) - INFO - Done attempting. 05:38:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:38:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:38:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:46 INFO - (blobuploader) - INFO - Done attempting. 05:38:46 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:46 INFO - Return code: 0 05:38:46 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:38:46 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bc763e253e0f36319033bab06df8b298993bc3cfdfce225eee403403377929e5d66e77d6845e8866f44c82e700bd1343d6073c48c248f32a70f92c649eda712", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4042ecf5fa274997497116d39b550f97e0475b665a1a5c8f8c2851b38be7aed2725344ebb6f9cdc142ebbc5bd94b88e804a7ef0a4bdc94232b692f1669c7696e"} 05:38:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:38:46 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:38:46 INFO - Contents: 05:38:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bc763e253e0f36319033bab06df8b298993bc3cfdfce225eee403403377929e5d66e77d6845e8866f44c82e700bd1343d6073c48c248f32a70f92c649eda712", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4042ecf5fa274997497116d39b550f97e0475b665a1a5c8f8c2851b38be7aed2725344ebb6f9cdc142ebbc5bd94b88e804a7ef0a4bdc94232b692f1669c7696e"} 05:38:46 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:46 INFO - Copying logs to upload dir... 05:38:46 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:38:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.590051 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2016-04-12 05:38:45.791886) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 05:38:45.795467) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bc763e253e0f36319033bab06df8b298993bc3cfdfce225eee403403377929e5d66e77d6845e8866f44c82e700bd1343d6073c48c248f32a70f92c649eda712", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4042ecf5fa274997497116d39b550f97e0475b665a1a5c8f8c2851b38be7aed2725344ebb6f9cdc142ebbc5bd94b88e804a7ef0a4bdc94232b692f1669c7696e"} build_url:https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/ITP_7CMUR8qM9rvh06NS2A/artifacts/public/build/firefox-46.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0bc763e253e0f36319033bab06df8b298993bc3cfdfce225eee403403377929e5d66e77d6845e8866f44c82e700bd1343d6073c48c248f32a70f92c649eda712", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4042ecf5fa274997497116d39b550f97e0475b665a1a5c8f8c2851b38be7aed2725344ebb6f9cdc142ebbc5bd94b88e804a7ef0a4bdc94232b692f1669c7696e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-12 05:38:45.820163) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:38:45.820512) ========= 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=5cf47e208febbcd81da23b2e0000026f-1460463334.879722-740372483 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004513 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-12 05:38:45.902795) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 05:38:45.903118) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-12 05:38:45.903400) ========= ========= Total master_lag: 0.34 =========