builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-037 starttime: 1456832751.45 results: success (0) buildid: 20160301010440 builduid: c7e86a43372340e580d566a1e4510cab revision: 6c5820c96c4a30cd3c8d248603fc4ed54bea29ac ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.449530) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.450149) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.450465) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006518 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.479867) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.480213) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.512216) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.512472) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.024544 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.561609) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.561911) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.562355) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.562632) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-01 03:45:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 221M=0s 2016-03-01 03:45:51 (221 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.166687 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.741913) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.742236) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.074551 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:51.829568) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 03:45:51.829954) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6c5820c96c4a30cd3c8d248603fc4ed54bea29ac --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6c5820c96c4a30cd3c8d248603fc4ed54bea29ac --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=aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-01 03:45:51,905 truncating revision to first 12 chars 2016-03-01 03:45:51,905 Setting DEBUG logging. 2016-03-01 03:45:51,905 attempt 1/10 2016-03-01 03:45:51,905 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6c5820c96c4a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-01 03:45:52,773 unpacking tar archive at: mozilla-aurora-6c5820c96c4a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.159109 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-01 03:45:53.002802) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:53.003218) ========= echo 6c5820c96c4a30cd3c8d248603fc4ed54bea29ac in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6c5820c96c4a30cd3c8d248603fc4ed54bea29ac'] 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=aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 6c5820c96c4a30cd3c8d248603fc4ed54bea29ac program finished with exit code 0 elapsedTime=0.003766 script_repo_revision: '6c5820c96c4a30cd3c8d248603fc4ed54bea29ac' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:53.052042) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:53.052353) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-01 03:45:53.062263) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-01 03:45:53.062585) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:45:53 INFO - MultiFileLogger online at 20160301 03:45:53 in /builds/slave/test-pgo 03:45:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 03:45:53 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 03:45:53 INFO - {'append_to_log': False, 03:45:53 INFO - 'base_work_dir': '/builds/slave/test-pgo', 03:45:53 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 03:45:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 03:45:53 INFO - 'branch': 'Mozilla-Aurora', 03:45:53 INFO - 'buildbot_json_path': 'buildprops.json', 03:45:53 INFO - 'config_files': ('talos/linux_config.py',), 03:45:53 INFO - 'default_actions': ('clobber', 03:45:53 INFO - 'read-buildbot-config', 03:45:53 INFO - 'download-and-extract', 03:45:53 INFO - 'populate-webroot', 03:45:53 INFO - 'create-virtualenv', 03:45:53 INFO - 'install', 03:45:53 INFO - 'run-tests'), 03:45:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:45:53 INFO - 'download_minidump_stackwalk': True, 03:45:53 INFO - 'download_symbols': 'ondemand', 03:45:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:45:53 INFO - 'tooltool.py': '/tools/tooltool.py', 03:45:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:45:53 INFO - '/tools/misc-python/virtualenv.py')}, 03:45:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:45:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:45:53 INFO - 'installer_path': 'installer.exe', 03:45:53 INFO - 'log_level': 'info', 03:45:53 INFO - 'log_name': 'talos', 03:45:53 INFO - 'log_to_console': True, 03:45:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:45:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:45:53 INFO - 'opt_config_files': (), 03:45:53 INFO - 'pip_index': False, 03:45:53 INFO - 'sps_profile': False, 03:45:53 INFO - 'sps_profile_interval': 0, 03:45:53 INFO - 'suite': 'dromaeojs-e10s', 03:45:53 INFO - 'system_bits': '32', 03:45:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:45:53 INFO - 'title': 'talos-linux64-ix-037', 03:45:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:45:53 INFO - 'use_talos_json': True, 03:45:53 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 03:45:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:45:53 INFO - 'work_dir': 'build'} 03:45:53 INFO - ##### 03:45:53 INFO - ##### Running clobber step. 03:45:53 INFO - ##### 03:45:53 INFO - Running pre-action listener: _resource_record_pre_action 03:45:53 INFO - Running main action method: clobber 03:45:53 INFO - rmtree: /builds/slave/test-pgo/build 03:45:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 03:45:58 INFO - Running post-action listener: _resource_record_post_action 03:45:58 INFO - ##### 03:45:58 INFO - ##### Running read-buildbot-config step. 03:45:58 INFO - ##### 03:45:58 INFO - Running pre-action listener: _resource_record_pre_action 03:45:58 INFO - Running main action method: read_buildbot_config 03:45:58 INFO - Using buildbot properties: 03:45:58 INFO - { 03:45:58 INFO - "project": "", 03:45:58 INFO - "product": "firefox", 03:45:58 INFO - "script_repo_revision": "production", 03:45:58 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 03:45:58 INFO - "repository": "", 03:45:58 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 03:45:58 INFO - "buildid": "20160301010440", 03:45:58 INFO - "pgo_build": "True", 03:45:58 INFO - "basedir": "/builds/slave/test-pgo", 03:45:58 INFO - "buildnumber": 172, 03:45:58 INFO - "slavename": "talos-linux64-ix-037", 03:45:58 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:45:58 INFO - "platform": "ubuntu64_hw", 03:45:58 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 03:45:58 INFO - "branch": "mozilla-aurora", 03:45:58 INFO - "repo_path": "releases/mozilla-aurora", 03:45:58 INFO - "revision": "6c5820c96c4a30cd3c8d248603fc4ed54bea29ac", 03:45:58 INFO - "stage_platform": "linux64-pgo", 03:45:58 INFO - "builduid": "c7e86a43372340e580d566a1e4510cab", 03:45:58 INFO - "slavebuilddir": "test" 03:45:58 INFO - } 03:45:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 03:45:58 INFO - Running post-action listener: _resource_record_post_action 03:45:58 INFO - ##### 03:45:58 INFO - ##### Running download-and-extract step. 03:45:58 INFO - ##### 03:45:58 INFO - Running pre-action listener: _resource_record_pre_action 03:45:58 INFO - Running main action method: download_and_extract 03:45:58 INFO - mkdir: /builds/slave/test-pgo/build/tests 03:45: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')]} 03:45:58 INFO - https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:45:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/test_packages.json 03:45:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/test_packages.json 03:45:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 03:45:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 03:46:01 INFO - Downloaded 1448 bytes. 03:46:01 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 03:46:01 INFO - Using the following test package requirements: 03:46:01 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:01 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:01 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 03:46:01 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:01 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 03:46:01 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:01 INFO - u'jsshell-linux-x86_64.zip'], 03:46:01 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:01 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 03:46:01 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:01 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:01 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 03:46:01 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:01 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 03:46:01 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:01 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 03:46:01 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 03:46:01 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 03:46:01 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 03:46:01 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:46:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:01 INFO - https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:46:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:46:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:46:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:06 INFO - Downloaded 23081926 bytes. 03:46:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:46:06 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:46:07 INFO - Return code: 0 03:46:07 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:46: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')]} 03:46:07 INFO - https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:46:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:46:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:46:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 03:46:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:46:08 INFO - Downloaded 23081926 bytes. 03:46:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:46:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 03:46:09 INFO - Return code: 0 03:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:09 INFO - https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:46:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 03:46:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:46:10 INFO - Downloaded 10706649 bytes. 03:46:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 03:46:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 03:46:10 INFO - Return code: 0 03:46:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:10 INFO - https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:46:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:46:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:46:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:46:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:46:12 INFO - Downloaded 59969275 bytes. 03:46:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:46:12 INFO - mkdir: /builds/slave/test-pgo/properties 03:46:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 03:46:12 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 03:46:12 INFO - Contents: 03:46:12 INFO - build_url:https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 03:46:13 INFO - Running post-action listener: _resource_record_post_action 03:46:13 INFO - Running post-action listener: set_extra_try_arguments 03:46:13 INFO - ##### 03:46:13 INFO - ##### Running populate-webroot step. 03:46:13 INFO - ##### 03:46:13 INFO - Running pre-action listener: _resource_record_pre_action 03:46:13 INFO - Running main action method: populate_webroot 03:46:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:46:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:46:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:46:13 INFO - '--tppagecycles', 03:46:13 INFO - '7'], 03:46:13 INFO - 'tests': ['tsvgm']}}, 03:46:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:46:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:46:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:46:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:46:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:46:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:13 INFO - 'talos_options': ['--e10s'], 03:46:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:46:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:13 INFO - 'tests': ['damp', 'tps']}, 03:46:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:13 INFO - 'talos_options': ['--e10s'], 03:46:13 INFO - 'tests': ['damp', 'tps']}, 03:46:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:46:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:46:13 INFO - 'other': {'tests': ['a11yr', 03:46:13 INFO - 'ts_paint', 03:46:13 INFO - 'tpaint', 03:46:13 INFO - 'sessionrestore', 03:46:13 INFO - 'sessionrestore_no_auto_restore']}, 03:46:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:46:13 INFO - 'tests': ['a11yr', 03:46:13 INFO - 'ts_paint', 03:46:13 INFO - 'tpaint', 03:46:13 INFO - 'sessionrestore', 03:46:13 INFO - 'sessionrestore_no_auto_restore']}, 03:46:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:46:13 INFO - 'tests': ['a11yr', 03:46:13 INFO - 'ts_paint', 03:46:13 INFO - 'tpaint', 03:46:13 INFO - 'sessionrestore', 03:46:13 INFO - 'sessionrestore_no_auto_restore']}, 03:46:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:46:13 INFO - 'tests': ['a11yr', 03:46:13 INFO - 'ts_paint', 03:46:13 INFO - 'tpaint', 03:46:13 INFO - 'sessionrestore', 03:46:13 INFO - 'sessionrestore_no_auto_restore']}, 03:46:13 INFO - 'other_l64': {'tests': ['a11yr', 03:46:13 INFO - 'ts_paint', 03:46:13 INFO - 'tpaint', 03:46:13 INFO - 'sessionrestore', 03:46:13 INFO - 'sessionrestore_no_auto_restore']}, 03:46:13 INFO - 'other_nol64': {'tests': ['a11yr', 03:46:13 INFO - 'ts_paint', 03:46:13 INFO - 'tpaint', 03:46:13 INFO - 'sessionrestore', 03:46:13 INFO - 'sessionrestore_no_auto_restore']}, 03:46:13 INFO - 'svgr': {'tests': ['tsvgx', 03:46:13 INFO - 'tsvgr_opacity', 03:46:13 INFO - 'tart', 03:46:13 INFO - 'tscrollx', 03:46:13 INFO - 'cart']}, 03:46:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:46:13 INFO - 'tests': ['tsvgx', 03:46:13 INFO - 'tsvgr_opacity', 03:46:13 INFO - 'tart', 03:46:13 INFO - 'tscrollx', 03:46:13 INFO - 'cart']}, 03:46:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:13 INFO - 'tests': ['tp5o']}, 03:46:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:13 INFO - 'talos_options': ['--e10s'], 03:46:13 INFO - 'tests': ['tp5o']}, 03:46:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:13 INFO - 'talos_options': ['--xperf_path', 03:46:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:13 INFO - 'tests': ['tp5n']}, 03:46:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:46:13 INFO - 'talos_options': ['--e10s', 03:46:13 INFO - '--xperf_path', 03:46:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:46:13 INFO - 'tests': ['tp5n']}}, 03:46:13 INFO - 'talos.zip': {'path': '', 03:46:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:46:13 INFO - Running post-action listener: _resource_record_post_action 03:46:13 INFO - ##### 03:46:13 INFO - ##### Running create-virtualenv step. 03:46:13 INFO - ##### 03:46:13 INFO - Running pre-action listener: _resource_record_pre_action 03:46:13 INFO - Running main action method: create_virtualenv 03:46:13 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 03:46:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 03:46:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 03:46:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:46:13 INFO - Using real prefix '/usr' 03:46:13 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 03:46:14 INFO - Installing distribute.............................................................................................................................................................................................done. 03:46:16 INFO - Installing pip.................done. 03:46:16 INFO - Return code: 0 03:46:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 03:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:16 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 0x7f5423ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 03:46:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:46:16 INFO - Using env: {'DISPLAY': ':0', 03:46:16 INFO - 'HOME': '/home/cltbld', 03:46:16 INFO - 'LANG': 'en_US.UTF-8', 03:46:16 INFO - 'LANGUAGE': 'en_US:en', 03:46:16 INFO - 'LOGNAME': 'cltbld', 03:46:16 INFO - 'MAIL': '/var/mail/cltbld', 03:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:16 INFO - 'MOZ_NO_REMOTE': '1', 03:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:16 INFO - 'NO_EM_RESTART': '1', 03:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:16 INFO - 'SHELL': '/bin/bash', 03:46:16 INFO - 'SHLVL': '1', 03:46:16 INFO - 'TERM': 'linux', 03:46:16 INFO - 'TMOUT': '86400', 03:46:16 INFO - 'USER': 'cltbld', 03:46:16 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:16 INFO - '_': '/tools/buildbot/bin/python'} 03:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:46:16 INFO - Cleaning up... 03:46:16 INFO - Return code: 0 03:46:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 03:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:16 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 0x7f5423ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:16 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 03:46:16 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:46:16 INFO - Using env: {'DISPLAY': ':0', 03:46:16 INFO - 'HOME': '/home/cltbld', 03:46:16 INFO - 'LANG': 'en_US.UTF-8', 03:46:16 INFO - 'LANGUAGE': 'en_US:en', 03:46:16 INFO - 'LOGNAME': 'cltbld', 03:46:16 INFO - 'MAIL': '/var/mail/cltbld', 03:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:16 INFO - 'MOZ_NO_REMOTE': '1', 03:46:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:16 INFO - 'NO_EM_RESTART': '1', 03:46:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:16 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:16 INFO - 'SHELL': '/bin/bash', 03:46:16 INFO - 'SHLVL': '1', 03:46:16 INFO - 'TERM': 'linux', 03:46:16 INFO - 'TMOUT': '86400', 03:46:16 INFO - 'USER': 'cltbld', 03:46:16 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:16 INFO - '_': '/tools/buildbot/bin/python'} 03:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:16 INFO - Downloading/unpacking psutil>=0.7.1 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46: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 03:46:18 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 03:46:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:18 INFO - Installing collected packages: psutil 03:46:18 INFO - Running setup.py install for psutil 03:46:18 INFO - building 'psutil._psutil_linux' extension 03:46:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:46:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:46:18 INFO - building 'psutil._psutil_posix' extension 03:46:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:46:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:46:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:46:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:46:19 INFO - Successfully installed psutil 03:46:19 INFO - Cleaning up... 03:46:19 INFO - Return code: 0 03:46:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 03:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:19 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 0x7f5423ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 03:46:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 03:46:19 INFO - Using env: {'DISPLAY': ':0', 03:46:19 INFO - 'HOME': '/home/cltbld', 03:46:19 INFO - 'LANG': 'en_US.UTF-8', 03:46:19 INFO - 'LANGUAGE': 'en_US:en', 03:46:19 INFO - 'LOGNAME': 'cltbld', 03:46:19 INFO - 'MAIL': '/var/mail/cltbld', 03:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:19 INFO - 'MOZ_NO_REMOTE': '1', 03:46:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:19 INFO - 'NO_EM_RESTART': '1', 03:46:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:19 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:19 INFO - 'SHELL': '/bin/bash', 03:46:19 INFO - 'SHLVL': '1', 03:46:19 INFO - 'TERM': 'linux', 03:46:19 INFO - 'TMOUT': '86400', 03:46:19 INFO - 'USER': 'cltbld', 03:46:19 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:19 INFO - '_': '/tools/buildbot/bin/python'} 03:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:21 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:46:21 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:46:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:46:21 INFO - Installing collected packages: mozsystemmonitor 03:46:21 INFO - Running setup.py install for mozsystemmonitor 03:46:21 INFO - Successfully installed mozsystemmonitor 03:46:21 INFO - Cleaning up... 03:46:21 INFO - Return code: 0 03:46:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 03:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:21 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 0x7f5423ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:21 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 03:46:21 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:46:21 INFO - Using env: {'DISPLAY': ':0', 03:46:21 INFO - 'HOME': '/home/cltbld', 03:46:21 INFO - 'LANG': 'en_US.UTF-8', 03:46:21 INFO - 'LANGUAGE': 'en_US:en', 03:46:21 INFO - 'LOGNAME': 'cltbld', 03:46:21 INFO - 'MAIL': '/var/mail/cltbld', 03:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:21 INFO - 'MOZ_NO_REMOTE': '1', 03:46:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:21 INFO - 'NO_EM_RESTART': '1', 03:46:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:21 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:21 INFO - 'SHELL': '/bin/bash', 03:46:21 INFO - 'SHLVL': '1', 03:46:21 INFO - 'TERM': 'linux', 03:46:21 INFO - 'TMOUT': '86400', 03:46:21 INFO - 'USER': 'cltbld', 03:46:21 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:21 INFO - '_': '/tools/buildbot/bin/python'} 03:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:21 INFO - Downloading/unpacking blobuploader==1.2.4 03:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:23 INFO - Downloading blobuploader-1.2.4.tar.gz 03:46:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:46:23 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:23 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 03:46:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:24 INFO - Downloading docopt-0.6.1.tar.gz 03:46:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 03:46:24 INFO - Installing collected packages: blobuploader, requests, docopt 03:46:24 INFO - Running setup.py install for blobuploader 03:46:24 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:46:24 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 03:46:24 INFO - Running setup.py install for requests 03:46:24 INFO - Running setup.py install for docopt 03:46:24 INFO - Successfully installed blobuploader requests docopt 03:46:24 INFO - Cleaning up... 03:46:24 INFO - Return code: 0 03:46:24 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:24 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 0x7f5423ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:24 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:46:24 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:24 INFO - Using env: {'DISPLAY': ':0', 03:46:24 INFO - 'HOME': '/home/cltbld', 03:46:24 INFO - 'LANG': 'en_US.UTF-8', 03:46:24 INFO - 'LANGUAGE': 'en_US:en', 03:46:24 INFO - 'LOGNAME': 'cltbld', 03:46:24 INFO - 'MAIL': '/var/mail/cltbld', 03:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:24 INFO - 'MOZ_NO_REMOTE': '1', 03:46:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:24 INFO - 'NO_EM_RESTART': '1', 03:46:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:24 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:24 INFO - 'SHELL': '/bin/bash', 03:46:24 INFO - 'SHLVL': '1', 03:46:24 INFO - 'TERM': 'linux', 03:46:24 INFO - 'TMOUT': '86400', 03:46:24 INFO - 'USER': 'cltbld', 03:46:24 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:24 INFO - '_': '/tools/buildbot/bin/python'} 03:46:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:25 INFO - Running setup.py (path:/tmp/pip-iXAzj4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:25 INFO - Running setup.py (path:/tmp/pip-4ozFvm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:25 INFO - Running setup.py (path:/tmp/pip-kuJUkl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:25 INFO - Running setup.py (path:/tmp/pip-p9Mo7O-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:25 INFO - Running setup.py (path:/tmp/pip-VL8qx9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:25 INFO - Running setup.py (path:/tmp/pip-y6JscT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:25 INFO - Running setup.py (path:/tmp/pip-YzUtgi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:25 INFO - Running setup.py (path:/tmp/pip-zGHREF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:25 INFO - Running setup.py (path:/tmp/pip-Tf8u9d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:25 INFO - Running setup.py (path:/tmp/pip-bENres-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:25 INFO - Running setup.py (path:/tmp/pip-aOnbkT-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:25 INFO - Running setup.py (path:/tmp/pip-O5ke5i-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:25 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:25 INFO - Running setup.py (path:/tmp/pip-AMaPMU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:26 INFO - Running setup.py (path:/tmp/pip-uOwoCq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:26 INFO - Running setup.py (path:/tmp/pip-6JFDjc-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:26 INFO - Running setup.py (path:/tmp/pip-WT2rSO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:26 INFO - Running setup.py (path:/tmp/pip-Xxm3df-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:46:26 INFO - Running setup.py install for manifestparser 03:46:26 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 03:46:26 INFO - Running setup.py install for mozcrash 03:46:26 INFO - Running setup.py install for mozdebug 03:46:26 INFO - Running setup.py install for mozdevice 03:46:26 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 03:46:26 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 03:46:26 INFO - Running setup.py install for mozfile 03:46:26 INFO - Running setup.py install for mozhttpd 03:46:26 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 03:46:26 INFO - Running setup.py install for mozinfo 03:46:27 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Running setup.py install for mozInstall 03:46:27 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Running setup.py install for mozleak 03:46:27 INFO - Running setup.py install for mozlog 03:46:27 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Running setup.py install for moznetwork 03:46:27 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Running setup.py install for mozprocess 03:46:27 INFO - Running setup.py install for mozprofile 03:46:27 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Running setup.py install for mozrunner 03:46:27 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 03:46:27 INFO - Running setup.py install for mozscreenshot 03:46:27 INFO - Running setup.py install for moztest 03:46:28 INFO - Running setup.py install for mozversion 03:46:28 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 03:46:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:46:28 INFO - Cleaning up... 03:46:28 INFO - Return code: 0 03:46:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:28 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 0x7f5423ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 03:46:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:28 INFO - Using env: {'DISPLAY': ':0', 03:46:28 INFO - 'HOME': '/home/cltbld', 03:46:28 INFO - 'LANG': 'en_US.UTF-8', 03:46:28 INFO - 'LANGUAGE': 'en_US:en', 03:46:28 INFO - 'LOGNAME': 'cltbld', 03:46:28 INFO - 'MAIL': '/var/mail/cltbld', 03:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:28 INFO - 'MOZ_NO_REMOTE': '1', 03:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:28 INFO - 'NO_EM_RESTART': '1', 03:46:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:28 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:28 INFO - 'SHELL': '/bin/bash', 03:46:28 INFO - 'SHLVL': '1', 03:46:28 INFO - 'TERM': 'linux', 03:46:28 INFO - 'TMOUT': '86400', 03:46:28 INFO - 'USER': 'cltbld', 03:46:28 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:28 INFO - '_': '/tools/buildbot/bin/python'} 03:46:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:28 INFO - Running setup.py (path:/tmp/pip-jfuuJr-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 03:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:28 INFO - Running setup.py (path:/tmp/pip-1EBT3Y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 03:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:28 INFO - Running setup.py (path:/tmp/pip-TBrQ0n-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 03:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:28 INFO - Running setup.py (path:/tmp/pip-d5spbp-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 03:46:28 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)) 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:28 INFO - Running setup.py (path:/tmp/pip-q5TeWz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 03:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:28 INFO - Running setup.py (path:/tmp/pip-Q8IVDW-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 03:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:28 INFO - Running setup.py (path:/tmp/pip-z8dBdi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 03:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:28 INFO - Running setup.py (path:/tmp/pip-NAq2lv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 03:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:28 INFO - Running setup.py (path:/tmp/pip-3p9SL4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 03:46:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 03:46:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:28 INFO - Running setup.py (path:/tmp/pip-IdbVqQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:29 INFO - Running setup.py (path:/tmp/pip-FdagGa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:29 INFO - Running setup.py (path:/tmp/pip-gHFHwX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:29 INFO - Running setup.py (path:/tmp/pip-LX9ibX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 03:46:29 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)) 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:29 INFO - Running setup.py (path:/tmp/pip-Z2nWoz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:29 INFO - Running setup.py (path:/tmp/pip-qi0lth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:29 INFO - Running setup.py (path:/tmp/pip-wV25qk-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 03:46:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:29 INFO - Running setup.py (path:/tmp/pip-ZnKmAm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 03:46:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 03:46:29 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)) 03:46:29 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)) 03:46:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:31 INFO - Downloading blessings-1.6.tar.gz 03:46:31 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 03:46:31 INFO - Installing collected packages: blessings 03:46:31 INFO - Running setup.py install for blessings 03:46:31 INFO - Successfully installed blessings 03:46:31 INFO - Cleaning up... 03:46:31 INFO - Return code: 0 03:46:31 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 03:46:31 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:46:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:46:31 INFO - Reading from file tmpfile_stdout 03:46:31 INFO - Current package versions: 03:46:31 INFO - argparse == 1.2.1 03:46:31 INFO - blessings == 1.6 03:46:31 INFO - blobuploader == 1.2.4 03:46:31 INFO - docopt == 0.6.1 03:46:31 INFO - manifestparser == 1.1 03:46:31 INFO - mozInstall == 1.12 03:46:31 INFO - mozcrash == 0.16 03:46:31 INFO - mozdebug == 0.1 03:46:31 INFO - mozdevice == 0.48 03:46:31 INFO - mozfile == 1.2 03:46:31 INFO - mozhttpd == 0.7 03:46:31 INFO - mozinfo == 0.9 03:46:31 INFO - mozleak == 0.1 03:46:31 INFO - mozlog == 3.1 03:46:31 INFO - moznetwork == 0.27 03:46:31 INFO - mozprocess == 0.22 03:46:31 INFO - mozprofile == 0.28 03:46:31 INFO - mozrunner == 6.11 03:46:31 INFO - mozscreenshot == 0.1 03:46:31 INFO - mozsystemmonitor == 0.0 03:46:31 INFO - moztest == 0.7 03:46:31 INFO - mozversion == 1.4 03:46:31 INFO - psutil == 3.1.1 03:46:31 INFO - requests == 1.2.3 03:46:31 INFO - wsgiref == 0.1.2 03:46:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 03:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:31 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 0x7f5423ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 03:46:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:31 INFO - Using env: {'DISPLAY': ':0', 03:46:31 INFO - 'HOME': '/home/cltbld', 03:46:31 INFO - 'LANG': 'en_US.UTF-8', 03:46:31 INFO - 'LANGUAGE': 'en_US:en', 03:46:31 INFO - 'LOGNAME': 'cltbld', 03:46:31 INFO - 'MAIL': '/var/mail/cltbld', 03:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:31 INFO - 'MOZ_NO_REMOTE': '1', 03:46:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:31 INFO - 'NO_EM_RESTART': '1', 03:46:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:31 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:31 INFO - 'SHELL': '/bin/bash', 03:46:31 INFO - 'SHLVL': '1', 03:46:31 INFO - 'TERM': 'linux', 03:46:31 INFO - 'TMOUT': '86400', 03:46:31 INFO - 'USER': 'cltbld', 03:46:31 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:31 INFO - '_': '/tools/buildbot/bin/python'} 03:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:32 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)) 03:46:32 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)) 03:46:32 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)) 03:46:32 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)) 03:46:32 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)) 03:46:32 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)) 03:46:32 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)) 03:46:32 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)) 03:46:32 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)) 03:46:32 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)) 03:46:32 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)) 03:46:32 INFO - Cleaning up... 03:46:32 INFO - Return code: 0 03:46:32 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 03:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:32 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 0x7f5423ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:32 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 03:46:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:46:32 INFO - Using env: {'DISPLAY': ':0', 03:46:32 INFO - 'HOME': '/home/cltbld', 03:46:32 INFO - 'LANG': 'en_US.UTF-8', 03:46:32 INFO - 'LANGUAGE': 'en_US:en', 03:46:32 INFO - 'LOGNAME': 'cltbld', 03:46:32 INFO - 'MAIL': '/var/mail/cltbld', 03:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:32 INFO - 'MOZ_NO_REMOTE': '1', 03:46:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:32 INFO - 'NO_EM_RESTART': '1', 03:46:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:32 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:32 INFO - 'SHELL': '/bin/bash', 03:46:32 INFO - 'SHLVL': '1', 03:46:32 INFO - 'TERM': 'linux', 03:46:32 INFO - 'TMOUT': '86400', 03:46:32 INFO - 'USER': 'cltbld', 03:46:32 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:32 INFO - '_': '/tools/buildbot/bin/python'} 03:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:32 INFO - Downloading/unpacking jsonschema 03:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:46:34 INFO - Downloading/unpacking functools32 (from jsonschema) 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:34 INFO - Downloading functools32-3.2.3-2.tar.gz 03:46:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 03:46:34 INFO - warning: no files found matching '*.txt' 03:46:34 INFO - no previously-included directories found matching 'build' 03:46:34 INFO - no previously-included directories found matching 'dist' 03:46:34 INFO - no previously-included directories found matching '.git*' 03:46:34 INFO - Installing collected packages: jsonschema, functools32 03:46:34 INFO - Running setup.py install for functools32 03:46:34 INFO - warning: no files found matching '*.txt' 03:46:34 INFO - no previously-included directories found matching 'build' 03:46:34 INFO - no previously-included directories found matching 'dist' 03:46:34 INFO - no previously-included directories found matching '.git*' 03:46:34 INFO - Successfully installed jsonschema functools32 03:46:34 INFO - Cleaning up... 03:46:34 INFO - Return code: 0 03:46:34 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 03:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:34 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 0x7f5423ad6f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c298a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cf6360>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, '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': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 03:46:34 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 03:46:34 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:46:34 INFO - Using env: {'DISPLAY': ':0', 03:46:34 INFO - 'HOME': '/home/cltbld', 03:46:34 INFO - 'LANG': 'en_US.UTF-8', 03:46:34 INFO - 'LANGUAGE': 'en_US:en', 03:46:34 INFO - 'LOGNAME': 'cltbld', 03:46:34 INFO - 'MAIL': '/var/mail/cltbld', 03:46:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:34 INFO - 'MOZ_NO_REMOTE': '1', 03:46:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:34 INFO - 'NO_EM_RESTART': '1', 03:46:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:34 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:34 INFO - 'SHELL': '/bin/bash', 03:46:34 INFO - 'SHLVL': '1', 03:46:34 INFO - 'TERM': 'linux', 03:46:34 INFO - 'TMOUT': '86400', 03:46:34 INFO - 'USER': 'cltbld', 03:46:34 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:34 INFO - '_': '/tools/buildbot/bin/python'} 03:46:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:34 INFO - Downloading/unpacking flake8 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:36 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:46:36 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:36 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:46:36 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:36 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 03:46:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:37 INFO - no previously-included directories found matching 'docs/_build' 03:46:37 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:46:37 INFO - Running setup.py install for pep8 03:46:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:37 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:37 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:37 INFO - no previously-included directories found matching 'docs/_build' 03:46:37 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 03:46:37 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:46:37 INFO - Cleaning up... 03:46:37 INFO - Return code: 0 03:46:37 INFO - Running post-action listener: _resource_record_post_action 03:46:37 INFO - Running post-action listener: _start_resource_monitoring 03:46:37 INFO - Starting resource monitoring. 03:46:37 INFO - ##### 03:46:37 INFO - ##### Running install step. 03:46:37 INFO - ##### 03:46:37 INFO - Running pre-action listener: _resource_record_pre_action 03:46:37 INFO - Running main action method: install 03:46:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 03:46:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 03:46:37 INFO - Reading from file tmpfile_stdout 03:46:37 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 03:46:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 03:46:37 INFO - Reading from file tmpfile_stdout 03:46:37 INFO - Output received: 03:46:37 INFO - Usage: mozinstall [options] installer 03:46:37 INFO - Options: 03:46:37 INFO - -h, --help show this help message and exit 03:46:37 INFO - -d DEST, --destination=DEST 03:46:37 INFO - Directory to install application into. [default: 03:46:37 INFO - "/builds/slave/test-pgo"] 03:46:37 INFO - --app=APP Application being installed. [default: firefox] 03:46:37 INFO - mkdir: /builds/slave/test-pgo/build/application 03:46:37 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 03:46:37 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 03:46:52 INFO - Reading from file tmpfile_stdout 03:46:52 INFO - Output received: 03:46:52 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 03:46:52 INFO - Running post-action listener: _resource_record_post_action 03:46:52 INFO - ##### 03:46:52 INFO - ##### Running run-tests step. 03:46:52 INFO - ##### 03:46:52 INFO - Running pre-action listener: _resource_record_pre_action 03:46:52 INFO - Running main action method: run_tests 03:46:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 03:46:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 03:46:52 INFO - Python 2.7.3 03:46:52 INFO - Return code: 0 03:46:52 INFO - grabbing minidump binary from tooltool 03:46:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:52 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 0x1d85540>, '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 0x1d86440>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d868f0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 03:46:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 03:46:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:46:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:52 INFO - Return code: 0 03:46:52 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 03:46:52 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 03:46:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 03:46:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 03:46:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 03:46:52 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 03:46:52 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 03:46:53 INFO - Return code: 0 03:46:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 03:46:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-037 --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 03:46:53 INFO - Using env: {'DISPLAY': ':0', 03:46:53 INFO - 'HOME': '/home/cltbld', 03:46:53 INFO - 'LANG': 'en_US.UTF-8', 03:46:53 INFO - 'LANGUAGE': 'en_US:en', 03:46:53 INFO - 'LOGNAME': 'cltbld', 03:46:53 INFO - 'MAIL': '/var/mail/cltbld', 03:46:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:46:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 03:46:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:53 INFO - 'MOZ_NO_REMOTE': '1', 03:46:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 03:46:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:53 INFO - 'NO_EM_RESTART': '1', 03:46:53 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 03:46:53 INFO - 'PWD': '/builds/slave/test-pgo', 03:46:53 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 03:46:53 INFO - 'SHELL': '/bin/bash', 03:46:53 INFO - 'SHLVL': '1', 03:46:53 INFO - 'TERM': 'linux', 03:46:53 INFO - 'TMOUT': '86400', 03:46:53 INFO - 'USER': 'cltbld', 03:46:53 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224', 03:46:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:53 INFO - '_': '/tools/buildbot/bin/python'} 03:46:53 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-037', '--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 03:46:54 INFO - mozversion application_buildid: 20160301010440 03:46:54 INFO - mozversion application_changeset: 6c5820c96c4a30cd3c8d248603fc4ed54bea29ac 03:46:54 INFO - mozversion application_display_name: FirefoxDeveloperEdition 03:46:54 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:54 INFO - mozversion application_name: Firefox 03:46:54 INFO - mozversion application_remotingname: firefox-dev 03:46:54 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:54 INFO - mozversion application_vendor: Mozilla 03:46:54 INFO - mozversion application_version: 46.0a2 03:46:54 INFO - mozversion platform_buildid: 20160301010440 03:46:54 INFO - mozversion platform_changeset: 6c5820c96c4a30cd3c8d248603fc4ed54bea29ac 03:46:54 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 03:46:54 INFO - mozversion platform_version: 46.0a2 03:46:54 INFO - using testdate: 1456832814 03:46:54 INFO - actual date: 1456832814 03:46:54 INFO - starting webserver on 'localhost:49893' 03:46:54 INFO - SUITE-START | Running 3 tests 03:46:54 INFO - TEST-START | dromaeo_css 03:46:54 INFO - operating with platform_type : linux_ 03:46:54 INFO - Initialising browser for dromaeo_css test... 03:46:54 INFO - TEST-INFO | started process 27547 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPK6QWp/profile http://localhost:49893/getInfo.html) 03:46:57 INFO - PROCESS | 27547 | 03:46:57 INFO - PROCESS | 27547 | (process:27625): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:46:59 INFO - PROCESS | 27547 | __metrics Screen width/height:1600/1200 03:46:59 INFO - PROCESS | 27547 | colorDepth:24 03:46:59 INFO - PROCESS | 27547 | Browser inner width/height: 1024/697 03:46:59 INFO - PROCESS | 27547 | __metrics 03:47:00 INFO - TEST-INFO | 27547: exit 0 03:47:00 INFO - Browser initialized. 03:47:00 INFO - Running cycle 1/1 for dromaeo_css test... 03:47:00 INFO - TEST-INFO | started process 27674 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpPK6QWp/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:47:01 INFO - PROCESS | 27674 | 03:47:01 INFO - PROCESS | 27674 | (process:27733): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 03:47:12 INFO - PROCESS | 27674 | RSS: Main: 141561856 03:47:12 INFO - PROCESS | 27674 | 03:48:01 INFO - PROCESS | 27674 | 1456832881927 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 03:50:09 INFO - PROCESS | 27674 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49893/tests/dromaeo/cssquery-ext.html) 03:50:10 INFO - PROCESS | 27674 | RSS: Main: 145719296 03:50:10 INFO - PROCESS | 27674 | 03:53:12 INFO - PROCESS | 27674 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-ext.html (next: http://localhost:49893/tests/dromaeo/cssquery-jquery.html) 03:53:13 INFO - PROCESS | 27674 | RSS: Main: 145092608 03:53:13 INFO - PROCESS | 27674 | 03:56:14 INFO - PROCESS | 27674 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49893/tests/dromaeo/cssquery-mootools.html) 03:56:15 INFO - PROCESS | 27674 | RSS: Main: 144805888 03:56:15 INFO - PROCESS | 27674 | 03:59:16 INFO - PROCESS | 27674 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49893/tests/dromaeo/cssquery-prototype.html) 03:59:17 INFO - PROCESS | 27674 | RSS: Main: 142786560 03:59:17 INFO - PROCESS | 27674 | 04:02:19 INFO - PROCESS | 27674 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49893/tests/dromaeo/cssquery-yui.html) 04:02:20 INFO - PROCESS | 27674 | RSS: Main: 143728640 04:02:20 INFO - PROCESS | 27674 | 04:05:22 INFO - PROCESS | 27674 | Cycle 1(1): loaded http://localhost:49893/tests/dromaeo/cssquery-yui.html (next: http://localhost:49893/tests/dromaeo/cssquery-dojo.html) 04:05:22 INFO - PROCESS | 27674 | RSS: Main: 146440192 04:05:22 INFO - PROCESS | 27674 | 04:05:22 INFO - PROCESS | 27674 | __start_tp_report 04:05:22 INFO - PROCESS | 27674 | _x_x_mozilla_page_load 04:05:22 INFO - PROCESS | 27674 | _x_x_mozilla_page_load_details 04:05:22 INFO - PROCESS | 27674 | |i|pagename|runs| 04:05:22 INFO - PROCESS | 27674 | |0;dojo.html;3349.6147942986554;3411.982940085301;3429.5027221052965;3441.1397150712323;3444.2250493638926;5516.503514683678;5571.4428557144265;5587.357453892803;5589.273394458724;5608.018596745568;5539.667619942807;5544.22380866679;5599.440055994409;5610.4670056344685;5637.492625663689;5035.9748201259035;5118.872028199287;5163.251328557357;5187.610929180308;5225.8954820903555;5010.273510340999;5026.371703537058;5147.253648221005;5154.561862241695;5159.32928719266;4998.025385049898;5051.797928082872;5065.468125846788;5069.340985671857;5121.718305493197;5087.643864929457;5099.847004589868;5101.540861322499;5123.001014802115;5132.435432102466;4925.310456536088;4967.205247160473;5023.120953833065;5024.673396229234;5027.49725027498;5214.296070030536;5230.895382092337;5238.81664141757;5260.132078207092;5268.367795864482;5805.36141024487;5815.73829177688;5862.20860183874;5863.237779088734;5876.706164691791;5793.565482588822;5871.970640146815;5880.735366908457;5934.851628709273;5975.372585878507;5602.075657516505;5629.7185140742795;5630.971845140748;5643.520300774439;5672.8865422691315;6058.606190597597;6092.786752463731;6099.359567245464;6109.572329936862;6126.019836826175;5843.970780146157;5871.3541510433815;5901.557383196192;5985.311689155803;5988.431099045583;5981.7607295707685;6001.219841420675;6004.309504407049;6012.488938440281;6014.09788531715;5903.35063143054;5963.612365196248;5969.641821490724;5978.491828194565;5991.700414979234;5808.6224395414165;5910.674912879746;5917.082852157922;5998.370171131968;6035.909461358083;4420.9336859947125;4476.060027394218;4479.686421950498;4491.887702807456;4505.774711264424;3973.443717879499;4076.286649836267;4083.632473077437;4086.346184610448;4092.1201941582704;5606.327240731139;5645.5483561314995;5659.717014149276;5682.232898558642;5711.800086997018;5983.401659833982;6009.519238460913;6049.516038716892;6072.210612620331;6077.361877002851;5400.405955344909;5496.340439147328;5497.257870187474;5645.661260324311;5667.886642267132;5078.542931136216;5128.256402821645;5156.639035267495;5193.662411943212;5195.038917800143;6166.136740856284;6196.0705894116245;6204.193454850841;6242.469390101892;6254.749810007549;5935.703214839327;6068.544859135494;6072.483838873657;6098.634081955097;6108.35862234459;5872.060470324727;6141.723622436912;6174.38256174379;6201.658908760061;6216.067589861376;5785.768569257182;5787.9131813021995;5793.304803423616;5808.361080281081;5808.912866306924;5760.539156867357;5883.146943693226;5891.23413956183;5899.705014749331;5926.081457374114;5756.280464941882;5794.449527294901;5849.590528662953;5864.091065884794;5891.1752354669525;5785.710714464344;5805.216295800182;5813.505852002458;5817.76728930838;5820.417958204146;5561.082421400423;5691.7438715257085;5719.7426115824055;5742.425757424224;5742.799002035076;5761.913571296518;5841.853953651193;5893.793717219876;5904.439078287556;5924.229850119457;5606.439356064524;5642.633228840113;5650.802221922213;5662.462066103713;5675.716214189191 04:05:22 INFO - PROCESS | 27674 | |1;ext.html;565.5362602665814;568.1250873654573;581.5899790647594;586.4751047812208;604.0878273806551;36812.263754724925;37602.81198594007;37642.24715505688;37654;37671.24657506848;38487.230255394876;38493.61506384936;38617.42073868894;38738.80630596843;38819.805900970525;8544.188302111304;8688.218060374566;8691.130886911322;8745.606447709837;8761.386702930797;8412.453190542596;8676.262517686004;8738.606762695663;8759.299256059532;8768.561571921411;8754.037055923844;8769.342299327544;8779.03430622631;8811.383203175781;8813.73558793234;8689.17452841979;8813.206811386974;8819.382643214978;8828.073052329477;8830.293576513928;8616.698415555487;8694.434861734031;8742.12578742127;8746.387752857303;8767.167119123673;38308.80845595782;39001.60998390008;39164.60835391638;39294;39333.60666393328;3512.332656795201;3636.709063274932;3684.705223582134;3736.215394767102;3754.4180651998986;31243.84378078118;31263;31359.686403135904;31363.5484878378;32234.83882580572;3855.4409610606303;3951.9604803952166;3995.1072168551445;4019.517657881073;4057.3102572562734;276524;276698;276865;277100;322631.9999999977;58517.4148258512;58872.41127588755;59513;59522.70238648866;59577.40422595805;62066.68966655138;62659.37340626626;62713;62724.68637656874;62834.685826570574;16297.266623001993;16346.918265408596;16357.67284654324;16424.83575164257;16442.917785410995;12762.361881905868;12871.356432178354;12888.162269452643;12905.935470322589;13009.154404963647;21565;21979.340619781433;22007.889960550096;22043.448913777283;22099.668504972436;8276.544790036485;8569.657213711382;8572.314214862796;8586.613602387908;8709.956450217709;1051.1538211739623;1057.4289883462998;1121.1199208621192;1144.719543711796;1160.8316794064813;27599.31001724933;27813.304667383072;28118.156455306373;32484.187895302806;33396.332073358884;1097.7475180708482;1168.463470536242;1227.5764861122898;1260.3446207971986;1303.4395210059765;14966;15217.771733424008;15340.616484587752;15664.92167539155;15693.764593531107;422383;482973;485917;488429;516281;57334.42665573374;58561.41438585645;59178.11232831511;59225.11162332568;59349.10976335358;1469.390203065737;1478.238707065862;1486.5466032860081;1490.9254537273093;1502.5492352294268;31615.051548453583;32194.517082244252;32454;33024.50463243102;33275.66724332822;49807.750961244965;49936;50038.249426257906;50378.2443263344;50554.74722626364;232835;233375;233517;233848;233895;44412.55587444084;44957;46618.300725489826;46817.53182468132;47299.52700472951;41646;41988;42080;42632.78683606562;42711.572884272005;39195;39810.402843956785;40117.39823902585;40428;41241.58758412497;39415.80292098521;39440.2111957765;39555.80222098871;39866;39983.2003359937;40024.799876000434;40492.39261411022;40681.18637627172;40959;41101.38347924723;34145.31709365849;34417.48373774446;34584.65415345915;35814.820925895205;36985;27272;27776.305592359546;27786.72213277922;27810.44379112366;27981.580276295466 04:05:22 INFO - PROCESS | 27674 | |2;jquery.html;384.94033424819156;386.6756359468819;390.3987858697608;390.7245391998641;393.343116994619;15468;16389.918050409746;16688.082155481443;18875;18940.147693353796;11276.830847537294;11457.942710286437;11598.188126831124;15982.76025859613;17173.484795456156;5079.085764562368;5249.606279529032;5292.735363231843;5293.497117773805;5727.6563406195555;5197.8440646780655;5361.222622719703;5387.218853266274;5397.568194544427;5588.972055139739;5186.818461353853;5311.57507399409;5364.6781193128345;5378.273933019032;5386.569074474032;5501.587380946425;5539.892021595697;5544.889102217953;5546.223528705985;5821.708914554255;5555.138953462219;5555.8888822223325;5569.248151499536;5571.9721401393135;5598.888022239533;12664.303463309514;13027.153235039692;13029.153105048237;13041.347932603427;13463;2293.4381076636164;2299.034405549673;2326.2904814031713;2334.241371554235;2346.2726554767905;9363;9496.572654230507;9760.804783904283;9934.701958941243;10077.941816109349;1900.9524761880925;1931.777845547766;1940.8835469871854;1950.2101648832245;1965.0469522281826;58178;59329.70335148297;59728.40271597272;59796.40203597952;60191.39808601902;10684.679459616224;10735.355878647306;10784.946075269574;10822.837657435144;10834.837477437844;14043.648908777363;14066;14082.85917140836;14144.504942326968;14176.362063707158;7765.689372425153;7791.727289544839;7892.763217103496;7923.7226697065325;7953.960230198812;7359.337659610661;7488.176300606929;7491.138519070268;7496;7579.431542634325;4537.387452693844;4613.1004454131125;4640.04878999811;4689.742064186435;4762.095201911626;1960.0983547568278;2013.3255359454454;2045.0490521907384;2055.9486012849798;2063.7420322459693;922.3174850610634;978.1636700620867;985.6500942165571;1014.4927536231884;1081.081081081075;16882.831171688373;17583.12084395775;17715.55711107207;17822;17869.821301786815;1014.2849291249652;1032.99483502582;1034.5861655337774;1053.7260312318851;1074.8387741838787;9431;9865.605375784888;9892.307538472382;9953.800923981624;10133.189344852393;568303;583200;585538;596468;602056;70578.64710676414;76465.61767191128;77722.6113869427;77841.61079194568;77982;1212.1514939542355;1221.2184202110657;1234.388977456147;1237.5482948723652;1254.5232811531741;14713.705725885207;14951.028183168059;15071.623209419853;15133.621659458602;15402.306896189475;31480.05559833209;31838.204044899063;31989.68010319867;32129.196770080936;32746.672533274363;44351.55648443474;44713.55286447094;44779.32831007472;45195.774021129684;45378;7676.923230767844;7777.4166937478785;7926.564038977912;7954.403419743427;8006.279434850891;11304.321740695585;11327.207095503236;11758;11962.162648614862;12137.817932731192;10148.79702405933;10689.572417103229;10829.350238985686;10880.455977201267;11106.666799996014;3212.405704944593;6571.704273307808;7246.89129663066;10650.467476625983;10824.729381765204;10473.266871318934;10764.946175269073;10849.132069434268;10947.452627368759;10969.50637221311;7850.371970242481;8062.4356295061125;8066.596670166351;8078.596070196584;8094.069182043905;10439.686809395731;10808.243422960317;10945.781084378108;11010.339379637247;11038.337699738042 04:05:22 INFO - PROCESS | 27674 | |3;mootools.html;1529.3270960777256;1551.418218168187;1802.522331582131;1908.7804902436224;1942.8154325339096;8096.271335579797;8319.667213311468;8324.209200125979;8534.658613655454;8552.486850788957;8507.787305317355;8518.87221691675;8594.871076933836;8618.138186181379;8647.524386158759;2393.7486563910843;2430.684011078566;2433.3065076453213;2435.281591930385;2436.415260337524;2427.5630386530415;2455.594826853567;2458.557459657261;2462.6059830427134;2486.266551367351;2343.0744855781954;2393.413613664655;2398.6881705378364;2406.651035599837;2421.007386971342;2413.1795189635523;2432.586460301753;2435.3546310227803;2435.427674496492;2454.9386265343333;2472.925812225636;2476.2695004973575;2479.219046000522;2482.714487833904;2487.751224877498;8388.958055209747;8455.450395724258;8457.53483558404;8459.873101903477;8489.490630562124;5038.193888977746;5166.018456493254;5169.767360468788;5175.120229560984;5186.559142472895;3152.4010438016703;3163.57291765611;3199.40810949975;3213.8232397218144;3220.21104829316;1017.6794309792392;1025.2566889005486;1037.6523864505325;1051.4900273367412;1075.3118004477142;11621.941890290578;11750.647480575512;11781.293122412682;11784.705382365424;11794.646160615195;4494.763939916549;4504.301833215857;4621.838235661803;4657.138429390574;4676.064787042537;10439.269251152346;10444.112250458644;10499.68500944973;10529.526171322308;10542.683719488428;5124.974375128175;5152.536271735562;5173.508516690908;5189.3253876996505;5195.896082078338;4541.886452838706;4677.345171675968;4689.60138388234;4704.929426058612;4705.376645057449;3847.480590120354;3872.5740168581433;3933.665638420709;3946.072672921861;3959.4456776051375;1184.6150001249628;1255.6421419895287;1284.3321472834261;1287.150480682745;1288.2013151845915;1419.7089596632666;1438.2736717957573;1451.8185226846645;1455.0324034516927;1485.8811295096582;7803.141654418009;7819.257170568787;7848.0582330119605;7858.253465920729;7883.881741773764;1209.9879001210052;1223.5350566784564;1225.307701148848;1236.4312416288428;1262.2552693910636;6191.226096737908;6306.747730090745;6312.589681670676;6319.462845658079;6373.840653983688;9880.40717556949;10060.647877324258;10097;10208.030237127461;10234.181265498892;9639.759006024766;9917.057879501435;10026.846912605144;10071.143952764098;10075.042870927251;8006.279434850891;8070.2333278338465;8110.188981101961;8153.347732181412;8159.184081591793;7675.692972281046;7711.768646940601;7756.612169391621;7778.533288002738;7786.26030527099;8636.913630863612;8773.122687731176;8795.736127916172;8839.646414143363;9059.864102038606;9003.099690030944;9266.166045055978;9275.768105797139;9279.76800579991;9343.81312373735;7384.889226661712;7526.698932042876;7530.058742657168;7537.8115547111765;7547.622618869144;7798.844023119619;7975.481593696391;8022.719204827803;8098.149694282251;8113;7177.102862142232;7203.099612548432;7575.734849280248;7705.075390953121;7890.250426209501;7208.243134470805;7240.782776516713;7280.745173918887;7336.266373362621;7409.925900741139;7327.523710958771;7397.297256760599;7411.703531858665;7452.739154129579;7638.388928885787;6826.2832402599;6858;6929.7228110875;6930.099087118642;6942.583444993316;7000.824979375557;7095.361417472453;7108.3602475777425;7137.964310178416;7215.494915355875 04:05:22 INFO - PROCESS | 27674 | |4;prototype.html;349.76915235944267;361.1566991075838;361.88962366478216;364.81212175729496;371.53558052434465;6308.905366419507;6309.4636955858805;6326.304106548282;6337.683115844206;6528.934710652892;6327.145835312232;6339.7464101436;6341.46097581705;6362;6404.519661025419;4895.265710143472;4895.681780684262;4905.705657660534;4910.705357678551;4914.311996320509;4916.655834091615;4918.901621967559;4921.926171107436;4930.890549626323;4947.50524947506;4631.39791827062;4725.621950243973;4756.28655701644;4791.161546729326;4804.90390192196;4759.119562880844;4794.712317260958;4798.0643774464;4813.566778989873;4837.661363704542;4225.901265670917;4245.490541135053;4246.490421149482;4252.064545799919;4254.617084462413;6007.128966299906;6041;6059.18201042858;6064.151018857319;6073.0283154695035;5548.667079975215;5655.547556195535;5691.288588926384;5694.117411801178;5694.5159661428825;6705.932940670579;6735.191776986793;6735.629540375277;6743.561668491581;6747.460203183734;4708.270218116198;4715.693479923794;4721.433427988629;4723.126221648971;4724.929126063112;6806.6256355900405;6992.5105242633035;7050.0482434871665;7071.116110486189;7115.501914865909;4761.999980004169;4790.568848803555;4792.257200133985;4794.2808578713475;4794.304825800239;4847.95152048482;4882.096812089775;4893.926591101136;4893.95106048942;4904.583110435581;5637.041702910433;5644.74598643062;5666.631668941505;5668.2064510967675;5668.971655141698;6605.471562275006;6772.72909083641;6823.147106611674;6825.931740682529;6923.169219693669;1695.4998275508754;1722.3455087066834;1723.3106757297182;1723.6380360124515;1727.576743697777;1153.3541216918552;1167.9416029198505;1168.3106966889577;1182.296533562529;1185.3658292813304;6473.546851720334;6474.838129046811;6484.157059582319;6486.870262594722;6492.5455218134275;6882;6913.170419549586;6948.131483564554;6952.409045231212;6953.89569156463;6307.432331090224;6391.872162556723;6426.132472116298;6429.099926010363;6446.419822215929;3748.2128752962185;3766.962330376716;3780.092777733324;3780.5085338906315;3789.1663833956486;7287.854242915112;7300.56196628204;7344.632768361561;7373.115226172894;7392.075990501187;7128.144622645315;7209.387202087776;7214.67533960973;7235.204127545966;7257.310555497219;7205.747798827016;7228.819279517949;7264.382527485117;7296.197418283985;7300.12398512182;6991.196012458632;7031.367176954099;7041.753538626123;7052.400545953651;7068.646567671699;6793.830154246183;6951.304869513008;6969.54697944632;6976.058232138799;6997.230304666585;7255.310745479171;7259.673314700745;7265.891011634935;7285.562866228043;7307.378872795872;4847.2729090636685;4871.48849370811;4885.2427873679635;4885.267209918541;4899.681520701143;6898.586084834926;7081.575105493687;7081.787546373617;7091.468139889425;7110.395616372666;6893.86251268535;6898.655067246517;6900.03399524077;6901.206361268519;6906.585604863724;6715.093462382712;6851.177858656793;6871.965640171967;6877.65611719422;6879.862402752017;6708.6310252936555;6753.3921947025;6753.86492270142;6759.594424334556;6772.695228714621;6858.417034552119;6893.482988775761;6902.516823822284;6909.792706218822;6914.792556223321;6464.967675161594;6646.435053020354;6649;6714.764983225759;6717.798466046026 04:05:22 INFO - PROCESS | 27674 | |5;yui.html;741.3698356397064;743.2641684732114;828.1759649149097;924.9953750231248;932.1796818799457;14302.427902883897;14382.137071775687;14418;14496.927515362422;14582.927085364558;14121.223332716696;14134.575962721108;14135.434582616708;14233.288335583205;14240.643983900407;714.1109318897979;726.415235735233;851.0425771007616;853.799357151069;875.3259989807844;816.9060558035812;860.320346925931;869.4305230074311;876.5836227791812;878.2973621103124;868.0885070675797;922.9446233226028;926.6061923682408;931.5994122527344;931.7251410833786;861.0786458489418;902.1970446302796;911.6353458616574;913.9817203655956;917.6375331743924;682.1984168601873;684.637142314574;686.9244383117853;688.3598253624127;688.7004153193377;13944.372503237379;13959.511417100453;14028.929855350658;14044.648883777885;14060.789088163685;14119.85880141206;14164.858351416457;14184.148951062969;14205.928970355082;14276.214808185545;10675.626353077605;10796.5681372745;10834.133269338434;10835.945820270848;11007.229493935427;3844.6539811417106;3877.961220387788;3878.2437424702193;3885.203533275672;3913.960860391388;48770.268445973335;49569;50044.499555004346;50248.497515024384;50646.24030639543;10757.731056723644;10846.891531084746;10984.95642913922;10995.890041099487;11113.166512511432;19629.607407851763;19654.803451965585;19737.210511579375;19756.308529201408;19756.308529201695;7156.856862862714;7228.96385518069;7237.565746055254;7411.629418529052;7598.962005190049;4221.303484924953;4245.532991370947;4257.659387249013;4262.893427664271;4268.509121451011;3240.756943229267;3260.7065364117343;3268.2809781847955;3273.050815263547;3283.326917981808;583.3087790967717;586.9207656966255;590.8700085981163;594.8423667728056;594.9464548190683;656.0983949375399;676.4216594811463;683.282553319013;715.8246229673659;733.2484203691259;8906.55467226636;9220.124088211609;9290.907090929139;9294.256459483226;9465.290103242147;654.8493846415352;742.9888551671729;749.975067318243;750.2834792772998;788.42051092447;4377.255866502702;4469.642428605704;4605.470370907322;4658.138244424792;4997.200447928314;59676.70161649251;59719.70140149271;60253.69873150606;60649;60676;51455.485445145816;53101.2034819478;54022.45977540253;54137.45862541403;54157;47132.764336178785;49363;49544.50455495471;50127.49872501228;50485;9628.75928101775;9672.468014259282;9858.211343092678;9918.801623967336;10041.598336066476;37120.814395927846;37926.24147516979;38246;38457.23085538218;38633.03417414587;44985;45101.77449112733;47224.2916356248;48197.51802481931;48294.27558586694;12171.634850954486;12532.686682833002;12597.87402125967;12660.17708848922;12799;12942.741145177231;13531.188128712309;13715.931420343233;13722.588322350346;13926.51257205993;12321.199122057038;12953.870461295266;13116.475340986253;13145.53990610324;13151.671208219488;11720.824187637363;12179;12196.085293603193;12200.206986545845;12743.044271679846;11395.145364097893;11875.049996000127;12164.635060948185;12611.621651350475;12836;10217.642382516577;10296.227782916461;10672.466376680979;10684.89315106839;10875.782484350111;10838.945805270923;10992.010719035005;11346.111697782395;11365;11404.429778510876 04:05:22 INFO - PROCESS | 27674 | __end_tp_report 04:05:22 INFO - PROCESS | 27674 | __start_cc_report 04:05:22 INFO - PROCESS | 27674 | _x_x_mozilla_cycle_collect,289 04:05:22 INFO - PROCESS | 27674 | __end_cc_report 04:05:22 INFO - PROCESS | 27674 | __startTimestamp1456833922719__endTimestamp 04:05:22 INFO - PROCESS | 27674 | 04:05:22 INFO - PROCESS | 27674 | ------- Summary: start ------- 04:05:22 INFO - PROCESS | 27674 | Number of tests: 6 04:05:22 INFO - PROCESS | 27674 | 04:05:22 INFO - PROCESS | 27674 | [#0] dojo.html Cycles:165 Average:5525.64 Median:5719.74 stddev:610.81 (10.7%) stddev-sans-first:588.35 04:05:22 INFO - PROCESS | 27674 | Values: 3349.6 3412.0 3429.5 3441.1 3444.2 5516.5 5571.4 5587.4 5589.3 5608.0 5539.7 5544.2 5599.4 5610.5 5637.5 5036.0 5118.9 5163.3 5187.6 5225.9 5010.3 5026.4 5147.3 5154.6 5159.3 4998.0 5051.8 5065.5 5069.3 5121.7 5087.6 5099.8 5101.5 5123.0 5132.4 4925.3 4967.2 5023.1 5024.7 5027.5 5214.3 5230.9 5238.8 5260.1 5268.4 5805.4 5815.7 5862.2 5863.2 5876.7 5793.6 5872.0 5880.7 5934.9 5975.4 5602.1 5629.7 5631.0 5643.5 5672.9 6058.6 6092.8 6099.4 6109.6 6126.0 5844.0 5871.4 5901.6 5985.3 5988.4 5981.8 6001.2 6004.3 6012.5 6014.1 5903.4 5963.6 5969.6 5978.5 5991.7 5808.6 5910.7 5917.1 5998.4 6035.9 4420.9 4476.1 4479.7 4491.9 4505.8 3973.4 4076.3 4083.6 4086.3 4092.1 5606.3 5645.5 5659.7 5682.2 5711.8 5983.4 6009.5 6049.5 6072.2 6077.4 5400.4 5496.3 5497.3 5645.7 5667.9 5078.5 5128.3 5156.6 5193.7 5195.0 6166.1 6196.1 6204.2 6242.5 6254.7 5935.7 6068.5 6072.5 6098.6 6108.4 5872.1 6141.7 6174.4 6201.7 6216.1 5785.8 5787.9 5793.3 5808.4 5808.9 5760.5 5883.1 5891.2 5899.7 5926.1 5756.3 5794.4 5849.6 5864.1 5891.2 5785.7 5805.2 5813.5 5817.8 5820.4 5561.1 5691.7 5719.7 5742.4 5742.8 5761.9 5841.9 5893.8 5904.4 5924.2 5606.4 5642.6 5650.8 5662.5 5675.7 04:05:22 INFO - PROCESS | 27674 | 04:05:22 INFO - PROCESS | 27674 | [#1] ext.html Cycles:180 Average:51131.99 Median:39313.80 stddev:92487.84 (235.3%) stddev-sans-first:92669.37 04:05:22 INFO - PROCESS | 27674 | Values: 565.5 568.1 581.6 586.5 604.1 36812.3 37602.8 37642.2 37654.0 37671.2 38487.2 38493.6 38617.4 38738.8 38819.8 8544.2 8688.2 8691.1 8745.6 8761.4 8412.5 8676.3 8738.6 8759.3 8768.6 8754.0 8769.3 8779.0 8811.4 8813.7 8689.2 8813.2 8819.4 8828.1 8830.3 8616.7 8694.4 8742.1 8746.4 8767.2 38308.8 39001.6 39164.6 39294.0 39333.6 3512.3 3636.7 3684.7 3736.2 3754.4 31243.8 31263.0 31359.7 31363.5 32234.8 3855.4 3952.0 3995.1 4019.5 4057.3 276524.0 276698.0 276865.0 277100.0 322632.0 58517.4 58872.4 59513.0 59522.7 59577.4 62066.7 62659.4 62713.0 62724.7 62834.7 16297.3 16346.9 16357.7 16424.8 16442.9 12762.4 12871.4 12888.2 12905.9 13009.2 21565.0 21979.3 22007.9 22043.4 22099.7 8276.5 8569.7 8572.3 8586.6 8710.0 1051.2 1057.4 1121.1 1144.7 1160.8 27599.3 27813.3 28118.2 32484.2 33396.3 1097.7 1168.5 1227.6 1260.3 1303.4 14966.0 15217.8 15340.6 15664.9 15693.8 422383.0 482973.0 485917.0 488429.0 516281.0 57334.4 58561.4 59178.1 59225.1 59349.1 1469.4 1478.2 1486.5 1490.9 1502.5 31615.1 32194.5 32454.0 33024.5 33275.7 49807.8 49936.0 50038.2 50378.2 50554.7 232835.0 233375.0 233517.0 233848.0 233895.0 44412.6 44957.0 46618.3 46817.5 47299.5 41646.0 41988.0 42080.0 42632.8 42711.6 39195.0 39810.4 40117.4 40428.0 41241.6 39415.8 39440.2 39555.8 39866.0 39983.2 40024.8 40492.4 40681.2 40959.0 41101.4 34145.3 34417.5 34584.7 35814.8 36985.0 27272.0 27776.3 27786.7 27810.4 27981.6 04:05:22 INFO - PROCESS | 27674 | 04:05:22 INFO - PROCESS | 27674 | [#2] jquery.html Cycles:180 Average:29036.64 Median:32437.93 stddev:95944.23 (295.8%) stddev-sans-first:96189.25 04:05:22 INFO - PROCESS | 27674 | Values: 384.9 386.7 390.4 390.7 393.3 15468.0 16389.9 16688.1 18875.0 18940.1 11276.8 11457.9 11598.2 15982.8 17173.5 5079.1 5249.6 5292.7 5293.5 5727.7 5197.8 5361.2 5387.2 5397.6 5589.0 5186.8 5311.6 5364.7 5378.3 5386.6 5501.6 5539.9 5544.9 5546.2 5821.7 5555.1 5555.9 5569.2 5572.0 5598.9 12664.3 13027.2 13029.2 13041.3 13463.0 2293.4 2299.0 2326.3 2334.2 2346.3 9363.0 9496.6 9760.8 9934.7 10077.9 1901.0 1931.8 1940.9 1950.2 1965.0 58178.0 59329.7 59728.4 59796.4 60191.4 10684.7 10735.4 10784.9 10822.8 10834.8 14043.6 14066.0 14082.9 14144.5 14176.4 7765.7 7791.7 7892.8 7923.7 7954.0 7359.3 7488.2 7491.1 7496.0 7579.4 4537.4 4613.1 4640.0 4689.7 4762.1 1960.1 2013.3 2045.0 2055.9 2063.7 922.3 978.2 985.7 1014.5 1081.1 16882.8 17583.1 17715.6 17822.0 17869.8 1014.3 1033.0 1034.6 1053.7 1074.8 9431.0 9865.6 9892.3 9953.8 10133.2 568303.0 583200.0 585538.0 596468.0 602056.0 70578.6 76465.6 77722.6 77841.6 77982.0 1212.2 1221.2 1234.4 1237.5 1254.5 14713.7 14951.0 15071.6 15133.6 15402.3 31480.1 31838.2 31989.7 32129.2 32746.7 44351.6 44713.6 44779.3 45195.8 45378.0 7676.9 7777.4 7926.6 7954.4 8006.3 11304.3 11327.2 11758.0 11962.2 12137.8 10148.8 10689.6 10829.4 10880.5 11106.7 3212.4 6571.7 7246.9 10650.5 10824.7 10473.3 10764.9 10849.1 10947.5 10969.5 7850.4 8062.4 8066.6 8078.6 8094.1 10439.7 10808.2 10945.8 11010.3 11038.3 04:05:22 INFO - PROCESS | 27674 | 04:05:22 INFO - PROCESS | 27674 | [#3] mootools.html Cycles:180 Average:5918.64 Median:5167.89 stddev:3068.19 (59.4%) stddev-sans-first:3059.06 04:05:22 INFO - PROCESS | 27674 | Values: 1529.3 1551.4 1802.5 1908.8 1942.8 8096.3 8319.7 8324.2 8534.7 8552.5 8507.8 8518.9 8594.9 8618.1 8647.5 2393.7 2430.7 2433.3 2435.3 2436.4 2427.6 2455.6 2458.6 2462.6 2486.3 2343.1 2393.4 2398.7 2406.7 2421.0 2413.2 2432.6 2435.4 2435.4 2454.9 2472.9 2476.3 2479.2 2482.7 2487.8 8389.0 8455.5 8457.5 8459.9 8489.5 5038.2 5166.0 5169.8 5175.1 5186.6 3152.4 3163.6 3199.4 3213.8 3220.2 1017.7 1025.3 1037.7 1051.5 1075.3 11621.9 11750.6 11781.3 11784.7 11794.6 4494.8 4504.3 4621.8 4657.1 4676.1 10439.3 10444.1 10499.7 10529.5 10542.7 5125.0 5152.5 5173.5 5189.3 5195.9 4541.9 4677.3 4689.6 4704.9 4705.4 3847.5 3872.6 3933.7 3946.1 3959.4 1184.6 1255.6 1284.3 1287.2 1288.2 1419.7 1438.3 1451.8 1455.0 1485.9 7803.1 7819.3 7848.1 7858.3 7883.9 1210.0 1223.5 1225.3 1236.4 1262.3 6191.2 6306.7 6312.6 6319.5 6373.8 9880.4 10060.6 10097.0 10208.0 10234.2 9639.8 9917.1 10026.8 10071.1 10075.0 8006.3 8070.2 8110.2 8153.3 8159.2 7675.7 7711.8 7756.6 7778.5 7786.3 8636.9 8773.1 8795.7 8839.6 9059.9 9003.1 9266.2 9275.8 9279.8 9343.8 7384.9 7526.7 7530.1 7537.8 7547.6 7798.8 7975.5 8022.7 8098.1 8113.0 7177.1 7203.1 7575.7 7705.1 7890.3 7208.2 7240.8 7280.7 7336.3 7409.9 7327.5 7397.3 7411.7 7452.7 7638.4 6826.3 6858.0 6929.7 6930.1 6942.6 7000.8 7095.4 7108.4 7138.0 7215.5 04:05:22 INFO - PROCESS | 27674 | 04:05:22 INFO - PROCESS | 27674 | [#4] prototype.html Cycles:180 Average:5679.66 Median:6415.33 stddev:1717.40 (26.8%) stddev-sans-first:1674.98 04:05:22 INFO - PROCESS | 27674 | Values: 349.8 361.2 361.9 364.8 371.5 6308.9 6309.5 6326.3 6337.7 6528.9 6327.1 6339.7 6341.5 6362.0 6404.5 4895.3 4895.7 4905.7 4910.7 4914.3 4916.7 4918.9 4921.9 4930.9 4947.5 4631.4 4725.6 4756.3 4791.2 4804.9 4759.1 4794.7 4798.1 4813.6 4837.7 4225.9 4245.5 4246.5 4252.1 4254.6 6007.1 6041.0 6059.2 6064.2 6073.0 5548.7 5655.5 5691.3 5694.1 5694.5 6705.9 6735.2 6735.6 6743.6 6747.5 4708.3 4715.7 4721.4 4723.1 4724.9 6806.6 6992.5 7050.0 7071.1 7115.5 4762.0 4790.6 4792.3 4794.3 4794.3 4848.0 4882.1 4893.9 4894.0 4904.6 5637.0 5644.7 5666.6 5668.2 5669.0 6605.5 6772.7 6823.1 6825.9 6923.2 1695.5 1722.3 1723.3 1723.6 1727.6 1153.4 1167.9 1168.3 1182.3 1185.4 6473.5 6474.8 6484.2 6486.9 6492.5 6882.0 6913.2 6948.1 6952.4 6953.9 6307.4 6391.9 6426.1 6429.1 6446.4 3748.2 3767.0 3780.1 3780.5 3789.2 7287.9 7300.6 7344.6 7373.1 7392.1 7128.1 7209.4 7214.7 7235.2 7257.3 7205.7 7228.8 7264.4 7296.2 7300.1 6991.2 7031.4 7041.8 7052.4 7068.6 6793.8 6951.3 6969.5 6976.1 6997.2 7255.3 7259.7 7265.9 7285.6 7307.4 4847.3 4871.5 4885.2 4885.3 4899.7 6898.6 7081.6 7081.8 7091.5 7110.4 6893.9 6898.7 6900.0 6901.2 6906.6 6715.1 6851.2 6872.0 6877.7 6879.9 6708.6 6753.4 6753.9 6759.6 6772.7 6858.4 6893.5 6902.5 6909.8 6914.8 6465.0 6646.4 6649.0 6714.8 6717.8 04:05:22 INFO - PROCESS | 27674 | 04:05:22 INFO - PROCESS | 27674 | [#5] yui.html Cycles:180 Average:14735.68 Median:4322.88 stddev:16711.75 (386.6%) stddev-sans-first:16725.58 04:05:22 INFO - PROCESS | 27674 | Values: 741.4 743.3 828.2 925.0 932.2 14302.4 14382.1 14418.0 14496.9 14582.9 14121.2 14134.6 14135.4 14233.3 14240.6 714.1 726.4 851.0 853.8 875.3 816.9 860.3 869.4 876.6 878.3 868.1 922.9 926.6 931.6 931.7 861.1 902.2 911.6 914.0 917.6 682.2 684.6 686.9 688.4 688.7 13944.4 13959.5 14028.9 14044.6 14060.8 14119.9 14164.9 14184.1 14205.9 14276.2 10675.6 10796.6 10834.1 10835.9 11007.2 3844.7 3878.0 3878.2 3885.2 3914.0 48770.3 49569.0 50044.5 50248.5 50646.2 10757.7 10846.9 10985.0 10995.9 11113.2 19629.6 19654.8 19737.2 19756.3 19756.3 7156.9 7229.0 7237.6 7411.6 7599.0 4221.3 4245.5 4257.7 4262.9 4268.5 3240.8 3260.7 3268.3 3273.1 3283.3 583.3 586.9 590.9 594.8 594.9 656.1 676.4 683.3 715.8 733.2 8906.6 9220.1 9290.9 9294.3 9465.3 654.8 743.0 750.0 750.3 788.4 4377.3 4469.6 4605.5 4658.1 4997.2 59676.7 59719.7 60253.7 60649.0 60676.0 51455.5 53101.2 54022.5 54137.5 54157.0 47132.8 49363.0 49544.5 50127.5 50485.0 9628.8 9672.5 9858.2 9918.8 10041.6 37120.8 37926.2 38246.0 38457.2 38633.0 44985.0 45101.8 47224.3 48197.5 48294.3 12171.6 12532.7 12597.9 12660.2 12799.0 12942.7 13531.2 13715.9 13722.6 13926.5 12321.2 12953.9 13116.5 13145.5 13151.7 11720.8 12179.0 12196.1 12200.2 12743.0 11395.1 11875.0 12164.6 12611.6 12836.0 10217.6 10296.2 10672.5 10684.9 10875.8 10838.9 10992.0 11346.1 11365.0 11404.4 04:05:22 INFO - PROCESS | 27674 | -------- Summary: end -------- 04:05:22 INFO - PROCESS | 27674 | 04:05:23 INFO - TEST-INFO | 27674: exit 0 04:05:23 INFO - TEST-OK | dromaeo_css | took 1109194ms 04:05:23 INFO - TEST-START | kraken 04:05:23 INFO - operating with platform_type : linux_ 04:05:23 INFO - Initialising browser for kraken test... 04:05:23 INFO - TEST-INFO | started process 27917 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUUuGG6/profile http://localhost:49893/getInfo.html) 04:05:27 INFO - PROCESS | 27917 | 04:05:27 INFO - PROCESS | 27917 | (process:27996): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:05:27 INFO - PROCESS | 27917 | __metrics Screen width/height:1600/1200 04:05:27 INFO - PROCESS | 27917 | colorDepth:24 04:05:27 INFO - PROCESS | 27917 | Browser inner width/height: 1024/697 04:05:27 INFO - PROCESS | 27917 | __metrics 04:05:28 INFO - TEST-INFO | 27917: exit 0 04:05:28 INFO - Browser initialized. 04:05:28 INFO - Running cycle 1/1 for kraken test... 04:05:28 INFO - TEST-INFO | started process 28045 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpUUuGG6/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:05:30 INFO - PROCESS | 28045 | 04:05:30 INFO - PROCESS | 28045 | (process:28112): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:05:40 INFO - PROCESS | 28045 | RSS: Main: 141725696 04:05:40 INFO - PROCESS | 28045 | 04:05:43 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49893/tests/kraken/driver.html?testName=audio-beat-detection) 04:05:43 INFO - PROCESS | 28045 | RSS: Main: 146427904 04:05:43 INFO - PROCESS | 28045 | 04:05:46 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49893/tests/kraken/driver.html?testName=audio-dft) 04:05:47 INFO - PROCESS | 28045 | RSS: Main: 146276352 04:05:47 INFO - PROCESS | 28045 | 04:05:49 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49893/tests/kraken/driver.html?testName=audio-fft) 04:05:50 INFO - PROCESS | 28045 | RSS: Main: 146452480 04:05:50 INFO - PROCESS | 28045 | 04:05:52 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49893/tests/kraken/driver.html?testName=audio-oscillator) 04:05:53 INFO - PROCESS | 28045 | RSS: Main: 145276928 04:05:53 INFO - PROCESS | 28045 | 04:05:55 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49893/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:05:55 INFO - PROCESS | 28045 | RSS: Main: 145379328 04:05:55 INFO - PROCESS | 28045 | 04:05:58 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49893/tests/kraken/driver.html?testName=imaging-darkroom) 04:05:59 INFO - PROCESS | 28045 | RSS: Main: 146624512 04:05:59 INFO - PROCESS | 28045 | 04:06:02 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49893/tests/kraken/driver.html?testName=imaging-desaturate) 04:06:03 INFO - PROCESS | 28045 | RSS: Main: 147668992 04:06:03 INFO - PROCESS | 28045 | 04:06:06 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49893/tests/kraken/driver.html?testName=json-parse-financial) 04:06:06 INFO - PROCESS | 28045 | RSS: Main: 146767872 04:06:06 INFO - PROCESS | 28045 | 04:06:08 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49893/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:06:08 INFO - PROCESS | 28045 | RSS: Main: 146374656 04:06:08 INFO - PROCESS | 28045 | 04:06:10 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49893/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:06:11 INFO - PROCESS | 28045 | RSS: Main: 145670144 04:06:11 INFO - PROCESS | 28045 | 04:06:13 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49893/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:06:13 INFO - PROCESS | 28045 | RSS: Main: 147251200 04:06:13 INFO - PROCESS | 28045 | 04:06:16 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:16 INFO - PROCESS | 28045 | RSS: Main: 148303872 04:06:16 INFO - PROCESS | 28045 | 04:06:19 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:19 INFO - PROCESS | 28045 | RSS: Main: 146862080 04:06:19 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | Cycle 1(1): loaded http://localhost:49893/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49893/tests/kraken/driver.html?testName=ai-astar) 04:06:21 INFO - PROCESS | 28045 | RSS: Main: 148484096 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | __start_tp_report 04:06:21 INFO - PROCESS | 28045 | _x_x_mozilla_page_load 04:06:21 INFO - PROCESS | 28045 | _x_x_mozilla_page_load_details 04:06:21 INFO - PROCESS | 28045 | |i|pagename|runs| 04:06:21 INFO - PROCESS | 28045 | |0;ai-astar;110;106;111;110;111;125;110;109;112;110 04:06:21 INFO - PROCESS | 28045 | |1;audio-beat-detection;149;126;148;171;128;152;154;123;161;128 04:06:21 INFO - PROCESS | 28045 | |2;audio-dft;162;162;161;160;163;161;161;161;163;160 04:06:21 INFO - PROCESS | 28045 | |3;audio-fft;74;73;75;157;76;75;73;76;154;72 04:06:21 INFO - PROCESS | 28045 | |4;audio-oscillator;97;96;149;95;96;95;137;96;95;139 04:06:21 INFO - PROCESS | 28045 | |5;imaging-gaussian-blur;110;109;109;110;110;109;111;111;110;110 04:06:21 INFO - PROCESS | 28045 | |6;imaging-darkroom;148;147;147;147;146;146;147;147;146;148 04:06:21 INFO - PROCESS | 28045 | |7;imaging-desaturate;96;97;97;96;97;96;97;96;97;97 04:06:21 INFO - PROCESS | 28045 | |8;json-parse-financial;52;56;57;55;55;55;56;57;53;55 04:06:21 INFO - PROCESS | 28045 | |9;json-stringify-tinderbox;65;65;64;64;65;65;66;64;64;65 04:06:21 INFO - PROCESS | 28045 | |10;stanford-crypto-aes;77;80;80;81;87;80;87;79;80;81 04:06:21 INFO - PROCESS | 28045 | |11;stanford-crypto-ccm;128;110;115;114;121;115;111;129;122;114 04:06:21 INFO - PROCESS | 28045 | |12;stanford-crypto-pbkdf2;138;134;132;125;125;122;144;140;127;135 04:06:21 INFO - PROCESS | 28045 | |13;stanford-crypto-sha256-iterative;66;66;68;65;68;67;64;64;66;65 04:06:21 INFO - PROCESS | 28045 | __end_tp_report 04:06:21 INFO - PROCESS | 28045 | __start_cc_report 04:06:21 INFO - PROCESS | 28045 | _x_x_mozilla_cycle_collect,732 04:06:21 INFO - PROCESS | 28045 | __end_cc_report 04:06:21 INFO - PROCESS | 28045 | __startTimestamp1456833981668__endTimestamp 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | ------- Summary: start ------- 04:06:21 INFO - PROCESS | 28045 | Number of tests: 14 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#0] ai-astar Cycles:10 Average:111.40 Median:110.50 stddev:5.04 (4.6%) stddev-sans-first:5.32 04:06:21 INFO - PROCESS | 28045 | Values: 110.0 106.0 111.0 110.0 111.0 125.0 110.0 109.0 112.0 110.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#1] audio-beat-detection Cycles:10 Average:144.00 Median:150.50 stddev:16.67 (11.1%) stddev-sans-first:17.58 04:06:21 INFO - PROCESS | 28045 | Values: 149.0 126.0 148.0 171.0 128.0 152.0 154.0 123.0 161.0 128.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 04:06:21 INFO - PROCESS | 28045 | Values: 162.0 162.0 161.0 160.0 163.0 161.0 161.0 161.0 163.0 160.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#3] audio-fft Cycles:10 Average:90.50 Median:74.50 stddev:34.29 (46.0%) stddev-sans-first:35.85 04:06:21 INFO - PROCESS | 28045 | Values: 74.0 73.0 75.0 157.0 76.0 75.0 73.0 76.0 154.0 72.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#4] audio-oscillator Cycles:10 Average:109.50 Median:95.50 stddev:22.41 (23.5%) stddev-sans-first:23.31 04:06:21 INFO - PROCESS | 28045 | Values: 97.0 96.0 149.0 95.0 96.0 95.0 137.0 96.0 95.0 139.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.78 04:06:21 INFO - PROCESS | 28045 | Values: 110.0 109.0 109.0 110.0 110.0 109.0 111.0 111.0 110.0 110.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 04:06:21 INFO - PROCESS | 28045 | Values: 148.0 147.0 147.0 147.0 146.0 146.0 147.0 147.0 146.0 148.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#7] imaging-desaturate Cycles:10 Average:96.60 Median:97.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:06:21 INFO - PROCESS | 28045 | Values: 96.0 97.0 97.0 96.0 97.0 96.0 97.0 96.0 97.0 97.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.60 (2.9%) stddev-sans-first:1.24 04:06:21 INFO - PROCESS | 28045 | Values: 52.0 56.0 57.0 55.0 55.0 55.0 56.0 57.0 53.0 55.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 04:06:21 INFO - PROCESS | 28045 | Values: 65.0 65.0 64.0 64.0 65.0 65.0 66.0 64.0 64.0 65.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:3.26 (4.0%) stddev-sans-first:3.08 04:06:21 INFO - PROCESS | 28045 | Values: 77.0 80.0 80.0 81.0 87.0 80.0 87.0 79.0 80.0 81.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:118.00 stddev:6.74 (5.7%) stddev-sans-first:6.08 04:06:21 INFO - PROCESS | 28045 | Values: 128.0 110.0 115.0 114.0 121.0 115.0 111.0 129.0 122.0 114.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:132.20 Median:134.50 stddev:7.30 (5.4%) stddev-sans-first:7.43 04:06:21 INFO - PROCESS | 28045 | Values: 138.0 134.0 132.0 125.0 125.0 122.0 144.0 140.0 127.0 135.0 04:06:21 INFO - PROCESS | 28045 | 04:06:21 INFO - PROCESS | 28045 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.45 (2.2%) stddev-sans-first:1.54 04:06:21 INFO - PROCESS | 28045 | Values: 66.0 66.0 68.0 65.0 68.0 67.0 64.0 64.0 66.0 65.0 04:06:21 INFO - PROCESS | 28045 | -------- Summary: end -------- 04:06:21 INFO - PROCESS | 28045 | 04:06:22 INFO - TEST-INFO | 28045: exit 0 04:06:22 INFO - TEST-OK | kraken | took 59189ms 04:06:22 INFO - TEST-START | v8_7 04:06:22 INFO - operating with platform_type : linux_ 04:06:22 INFO - Initialising browser for v8_7 test... 04:06:22 INFO - TEST-INFO | started process 28342 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWqBA_E/profile http://localhost:49893/getInfo.html) 04:06:26 INFO - PROCESS | 28342 | 04:06:26 INFO - PROCESS | 28342 | (process:28421): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:27 INFO - PROCESS | 28342 | __metrics Screen width/height:1600/1200 04:06:27 INFO - PROCESS | 28342 | colorDepth:24 04:06:27 INFO - PROCESS | 28342 | Browser inner width/height: 1024/697 04:06:27 INFO - PROCESS | 28342 | __metrics 04:06:27 INFO - TEST-INFO | 28342: exit 0 04:06:27 INFO - Browser initialized. 04:06:27 INFO - Running cycle 1/1 for v8_7 test... 04:06:27 INFO - TEST-INFO | started process 28470 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpWqBA_E/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:06:29 INFO - PROCESS | 28470 | 04:06:29 INFO - PROCESS | 28470 | (process:28532): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 04:06:39 INFO - PROCESS | 28470 | RSS: Main: 140443648 04:06:39 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | Cycle 1(1): loaded http://localhost:49893/tests/v8_7/run.html (next: http://localhost:49893/tests/v8_7/run.html) 04:07:02 INFO - PROCESS | 28470 | RSS: Main: 144494592 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | __start_tp_report 04:07:02 INFO - PROCESS | 28470 | _x_x_mozilla_page_load 04:07:02 INFO - PROCESS | 28470 | _x_x_mozilla_page_load_details 04:07:02 INFO - PROCESS | 28470 | |i|pagename|runs| 04:07:02 INFO - PROCESS | 28470 | |0;Richards;166.41704110500916 04:07:02 INFO - PROCESS | 28470 | |1;DeltaBlue;170.1837985023826 04:07:02 INFO - PROCESS | 28470 | |2;Encrypt;277.77777777777777 04:07:02 INFO - PROCESS | 28470 | |3;Decrypt;5240.837696335078 04:07:02 INFO - PROCESS | 28470 | |4;RayTrace;951.4747859181732 04:07:02 INFO - PROCESS | 28470 | |5;Earley;549.7526113249038 04:07:02 INFO - PROCESS | 28470 | |6;Boyer;11177.777777777777 04:07:02 INFO - PROCESS | 28470 | |7;RegExp;39211.53846153846 04:07:02 INFO - PROCESS | 28470 | |8;Splay;521.376433785193 04:07:02 INFO - PROCESS | 28470 | |9;NavierStokes;4822.115384615385 04:07:02 INFO - PROCESS | 28470 | __end_tp_report 04:07:02 INFO - PROCESS | 28470 | __startTimestamp1456834022344__endTimestamp 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | ------- Summary: start ------- 04:07:02 INFO - PROCESS | 28470 | Number of tests: 10 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#0] Richards Cycles:1 Average:166.42 Median:166.42 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 166.4 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#1] DeltaBlue Cycles:1 Average:170.18 Median:170.18 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 170.2 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#2] Encrypt Cycles:1 Average:277.78 Median:277.78 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 277.8 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#3] Decrypt Cycles:1 Average:5240.84 Median:5240.84 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 5240.8 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#4] RayTrace Cycles:1 Average:951.47 Median:951.47 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 951.5 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#5] Earley Cycles:1 Average:549.75 Median:549.75 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 549.8 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#6] Boyer Cycles:1 Average:11177.78 Median:11177.78 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 11177.8 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#7] RegExp Cycles:1 Average:39211.54 Median:39211.54 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 39211.5 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#8] Splay Cycles:1 Average:521.38 Median:521.38 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 521.4 04:07:02 INFO - PROCESS | 28470 | 04:07:02 INFO - PROCESS | 28470 | [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 04:07:02 INFO - PROCESS | 28470 | Values: 4822.1 04:07:02 INFO - PROCESS | 28470 | -------- Summary: end -------- 04:07:02 INFO - PROCESS | 28470 | 04:07:03 INFO - TEST-INFO | 28470: exit 0 04:07:03 INFO - TEST-OK | v8_7 | took 40710ms 04:07:03 INFO - SUITE-END | took 1209s 04:07:03 INFO - Completed test suite (00:20:09) 04:07:03 INFO - Working with test: dromaeo_css 04:07:03 INFO - Generating results file: dromaeo_css 04:07:03 INFO - Working with test: kraken 04:07:03 INFO - Generating results file: kraken 04:07:03 INFO - javascript benchmark 04:07:03 INFO - Working with test: v8_7 04:07:03 INFO - Generating results file: v8_7 04:07:03 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 04:07:03 INFO - process_Request line: dromaeo_css 7318.43 graph.html#tests=[[72,52,43]] 04:07:03 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:03 INFO - process_Request line: kraken 1487.20 graph.html#tests=[[232,52,43]] 04:07:03 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:07:03 INFO - process_Request line: v8_7 22000.74 graph.html#tests=[[230,52,43]] 04:07:03 INFO - RETURN: dromaeo_css: 7318.43 04:07:03 INFO - RETURN: kraken: 1487.20 04:07:03 INFO - RETURN: v8_7: 22000.74 04:07:03 INFO - javascript benchmark 04:07:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3349.6147942986554, 3411.982940085301, 3429.5027221052965, 3441.1397150712323, 3444.2250493638926, 5516.503514683678, 5571.4428557144265, 5587.357453892803, 5589.273394458724, 5608.018596745568, 5539.667619942807, 5544.22380866679, 5599.440055994409, 5610.4670056344685, 5637.492625663689, 5035.9748201259035, 5118.872028199287, 5163.251328557357, 5187.610929180308, 5225.8954820903555, 5010.273510340999, 5026.371703537058, 5147.253648221005, 5154.561862241695, 5159.32928719266, 4998.025385049898, 5051.797928082872, 5065.468125846788, 5069.340985671857, 5121.718305493197, 5087.643864929457, 5099.847004589868, 5101.540861322499, 5123.001014802115, 5132.435432102466, 4925.310456536088, 4967.205247160473, 5023.120953833065, 5024.673396229234, 5027.49725027498, 5214.296070030536, 5230.895382092337, 5238.81664141757, 5260.132078207092, 5268.367795864482, 5805.36141024487, 5815.73829177688, 5862.20860183874, 5863.237779088734, 5876.706164691791, 5793.565482588822, 5871.970640146815, 5880.735366908457, 5934.851628709273, 5975.372585878507, 5602.075657516505, 5629.7185140742795, 5630.971845140748, 5643.520300774439, 5672.8865422691315, 6058.606190597597, 6092.786752463731, 6099.359567245464, 6109.572329936862, 6126.019836826175, 5843.970780146157, 5871.3541510433815, 5901.557383196192, 5985.311689155803, 5988.431099045583, 5981.7607295707685, 6001.219841420675, 6004.309504407049, 6012.488938440281, 6014.09788531715, 5903.35063143054, 5963.612365196248, 5969.641821490724, 5978.491828194565, 5991.700414979234, 5808.6224395414165, 5910.674912879746, 5917.082852157922, 5998.370171131968, 6035.909461358083, 4420.9336859947125, 4476.060027394218, 4479.686421950498, 4491.887702807456, 4505.774711264424, 3973.443717879499, 4076.286649836267, 4083.632473077437, 4086.346184610448, 4092.1201941582704, 5606.327240731139, 5645.5483561314995, 5659.717014149276, 5682.232898558642, 5711.800086997018, 5983.401659833982, 6009.519238460913, 6049.516038716892, 6072.210612620331, 6077.361877002851, 5400.405955344909, 5496.340439147328, 5497.257870187474, 5645.661260324311, 5667.886642267132, 5078.542931136216, 5128.256402821645, 5156.639035267495, 5193.662411943212, 5195.038917800143, 6166.136740856284, 6196.0705894116245, 6204.193454850841, 6242.469390101892, 6254.749810007549, 5935.703214839327, 6068.544859135494, 6072.483838873657, 6098.634081955097, 6108.35862234459, 5872.060470324727, 6141.723622436912, 6174.38256174379, 6201.658908760061, 6216.067589861376, 5785.768569257182, 5787.9131813021995, 5793.304803423616, 5808.361080281081, 5808.912866306924, 5760.539156867357, 5883.146943693226, 5891.23413956183, 5899.705014749331, 5926.081457374114, 5756.280464941882, 5794.449527294901, 5849.590528662953, 5864.091065884794, 5891.1752354669525, 5785.710714464344, 5805.216295800182, 5813.505852002458, 5817.76728930838, 5820.417958204146, 5561.082421400423, 5691.7438715257085, 5719.7426115824055, 5742.425757424224, 5742.799002035076, 5761.913571296518, 5841.853953651193, 5893.793717219876, 5904.439078287556, 5924.229850119457, 5606.439356064524, 5642.633228840113, 5650.802221922213, 5662.462066103713, 5675.716214189191], "unit": "score", "name": "dojo.html", "value": 5486.614082312325}, {"lowerIsBetter": false, "replicates": [565.5362602665814, 568.1250873654573, 581.5899790647594, 586.4751047812208, 604.0878273806551, 36812.263754724925, 37602.81198594007, 37642.24715505688, 37654.0, 37671.24657506848, 38487.230255394876, 38493.61506384936, 38617.42073868894, 38738.80630596843, 38819.805900970525, 8544.188302111304, 8688.218060374566, 8691.130886911322, 8745.606447709837, 8761.386702930797, 8412.453190542596, 8676.262517686004, 8738.606762695663, 8759.299256059532, 8768.561571921411, 8754.037055923844, 8769.342299327544, 8779.03430622631, 8811.383203175781, 8813.73558793234, 8689.17452841979, 8813.206811386974, 8819.382643214978, 8828.073052329477, 8830.293576513928, 8616.698415555487, 8694.434861734031, 8742.12578742127, 8746.387752857303, 8767.167119123673, 38308.80845595782, 39001.60998390008, 39164.60835391638, 39294.0, 39333.60666393328, 3512.332656795201, 3636.709063274932, 3684.705223582134, 3736.215394767102, 3754.4180651998986, 31243.84378078118, 31263.0, 31359.686403135904, 31363.5484878378, 32234.83882580572, 3855.4409610606303, 3951.9604803952166, 3995.1072168551445, 4019.517657881073, 4057.3102572562734, 276524.0, 276698.0, 276865.0, 277100.0, 322631.9999999977, 58517.4148258512, 58872.41127588755, 59513.0, 59522.70238648866, 59577.40422595805, 62066.68966655138, 62659.37340626626, 62713.0, 62724.68637656874, 62834.685826570574, 16297.266623001993, 16346.918265408596, 16357.67284654324, 16424.83575164257, 16442.917785410995, 12762.361881905868, 12871.356432178354, 12888.162269452643, 12905.935470322589, 13009.154404963647, 21565.0, 21979.340619781433, 22007.889960550096, 22043.448913777283, 22099.668504972436, 8276.544790036485, 8569.657213711382, 8572.314214862796, 8586.613602387908, 8709.956450217709, 1051.1538211739623, 1057.4289883462998, 1121.1199208621192, 1144.719543711796, 1160.8316794064813, 27599.31001724933, 27813.304667383072, 28118.156455306373, 32484.187895302806, 33396.332073358884, 1097.7475180708482, 1168.463470536242, 1227.5764861122898, 1260.3446207971986, 1303.4395210059765, 14966.0, 15217.771733424008, 15340.616484587752, 15664.92167539155, 15693.764593531107, 422383.0, 482973.0, 485917.0, 488429.0, 516281.0, 57334.42665573374, 58561.41438585645, 59178.11232831511, 59225.11162332568, 59349.10976335358, 1469.390203065737, 1478.238707065862, 1486.5466032860081, 1490.9254537273093, 1502.5492352294268, 31615.051548453583, 32194.517082244252, 32454.0, 33024.50463243102, 33275.66724332822, 49807.750961244965, 49936.0, 50038.249426257906, 50378.2443263344, 50554.74722626364, 232835.0, 233375.0, 233517.0, 233848.0, 233895.0, 44412.55587444084, 44957.0, 46618.300725489826, 46817.53182468132, 47299.52700472951, 41646.0, 41988.0, 42080.0, 42632.78683606562, 42711.572884272005, 39195.0, 39810.402843956785, 40117.39823902585, 40428.0, 41241.58758412497, 39415.80292098521, 39440.2111957765, 39555.80222098871, 39866.0, 39983.2003359937, 40024.799876000434, 40492.39261411022, 40681.18637627172, 40959.0, 41101.38347924723, 34145.31709365849, 34417.48373774446, 34584.65415345915, 35814.820925895205, 36985.0, 27272.0, 27776.305592359546, 27786.72213277922, 27810.44379112366, 27981.580276295466], "unit": "score", "name": "ext.html", "value": 19683.487023740865}, {"lowerIsBetter": false, "replicates": [384.94033424819156, 386.6756359468819, 390.3987858697608, 390.7245391998641, 393.343116994619, 15468.0, 16389.918050409746, 16688.082155481443, 18875.0, 18940.147693353796, 11276.830847537294, 11457.942710286437, 11598.188126831124, 15982.76025859613, 17173.484795456156, 5079.085764562368, 5249.606279529032, 5292.735363231843, 5293.497117773805, 5727.6563406195555, 5197.8440646780655, 5361.222622719703, 5387.218853266274, 5397.568194544427, 5588.972055139739, 5186.818461353853, 5311.57507399409, 5364.6781193128345, 5378.273933019032, 5386.569074474032, 5501.587380946425, 5539.892021595697, 5544.889102217953, 5546.223528705985, 5821.708914554255, 5555.138953462219, 5555.8888822223325, 5569.248151499536, 5571.9721401393135, 5598.888022239533, 12664.303463309514, 13027.153235039692, 13029.153105048237, 13041.347932603427, 13463.0, 2293.4381076636164, 2299.034405549673, 2326.2904814031713, 2334.241371554235, 2346.2726554767905, 9363.0, 9496.572654230507, 9760.804783904283, 9934.701958941243, 10077.941816109349, 1900.9524761880925, 1931.777845547766, 1940.8835469871854, 1950.2101648832245, 1965.0469522281826, 58178.0, 59329.70335148297, 59728.40271597272, 59796.40203597952, 60191.39808601902, 10684.679459616224, 10735.355878647306, 10784.946075269574, 10822.837657435144, 10834.837477437844, 14043.648908777363, 14066.0, 14082.85917140836, 14144.504942326968, 14176.362063707158, 7765.689372425153, 7791.727289544839, 7892.763217103496, 7923.7226697065325, 7953.960230198812, 7359.337659610661, 7488.176300606929, 7491.138519070268, 7496.0, 7579.431542634325, 4537.387452693844, 4613.1004454131125, 4640.04878999811, 4689.742064186435, 4762.095201911626, 1960.0983547568278, 2013.3255359454454, 2045.0490521907384, 2055.9486012849798, 2063.7420322459693, 922.3174850610634, 978.1636700620867, 985.6500942165571, 1014.4927536231884, 1081.081081081075, 16882.831171688373, 17583.12084395775, 17715.55711107207, 17822.0, 17869.821301786815, 1014.2849291249652, 1032.99483502582, 1034.5861655337774, 1053.7260312318851, 1074.8387741838787, 9431.0, 9865.605375784888, 9892.307538472382, 9953.800923981624, 10133.189344852393, 568303.0, 583200.0, 585538.0, 596468.0, 602056.0, 70578.64710676414, 76465.61767191128, 77722.6113869427, 77841.61079194568, 77982.0, 1212.1514939542355, 1221.2184202110657, 1234.388977456147, 1237.5482948723652, 1254.5232811531741, 14713.705725885207, 14951.028183168059, 15071.623209419853, 15133.621659458602, 15402.306896189475, 31480.05559833209, 31838.204044899063, 31989.68010319867, 32129.196770080936, 32746.672533274363, 44351.55648443474, 44713.55286447094, 44779.32831007472, 45195.774021129684, 45378.0, 7676.923230767844, 7777.4166937478785, 7926.564038977912, 7954.403419743427, 8006.279434850891, 11304.321740695585, 11327.207095503236, 11758.0, 11962.162648614862, 12137.817932731192, 10148.79702405933, 10689.572417103229, 10829.350238985686, 10880.455977201267, 11106.666799996014, 3212.405704944593, 6571.704273307808, 7246.89129663066, 10650.467476625983, 10824.729381765204, 10473.266871318934, 10764.946175269073, 10849.132069434268, 10947.452627368759, 10969.50637221311, 7850.371970242481, 8062.4356295061125, 8066.596670166351, 8078.596070196584, 8094.069182043905, 10439.686809395731, 10808.243422960317, 10945.781084378108, 11010.339379637247, 11038.337699738042], "unit": "score", "name": "jquery.html", "value": 8402.991064022992}, {"lowerIsBetter": false, "replicates": [1529.3270960777256, 1551.418218168187, 1802.522331582131, 1908.7804902436224, 1942.8154325339096, 8096.271335579797, 8319.667213311468, 8324.209200125979, 8534.658613655454, 8552.486850788957, 8507.787305317355, 8518.87221691675, 8594.871076933836, 8618.138186181379, 8647.524386158759, 2393.7486563910843, 2430.684011078566, 2433.3065076453213, 2435.281591930385, 2436.415260337524, 2427.5630386530415, 2455.594826853567, 2458.557459657261, 2462.6059830427134, 2486.266551367351, 2343.0744855781954, 2393.413613664655, 2398.6881705378364, 2406.651035599837, 2421.007386971342, 2413.1795189635523, 2432.586460301753, 2435.3546310227803, 2435.427674496492, 2454.9386265343333, 2472.925812225636, 2476.2695004973575, 2479.219046000522, 2482.714487833904, 2487.751224877498, 8388.958055209747, 8455.450395724258, 8457.53483558404, 8459.873101903477, 8489.490630562124, 5038.193888977746, 5166.018456493254, 5169.767360468788, 5175.120229560984, 5186.559142472895, 3152.4010438016703, 3163.57291765611, 3199.40810949975, 3213.8232397218144, 3220.21104829316, 1017.6794309792392, 1025.2566889005486, 1037.6523864505325, 1051.4900273367412, 1075.3118004477142, 11621.941890290578, 11750.647480575512, 11781.293122412682, 11784.705382365424, 11794.646160615195, 4494.763939916549, 4504.301833215857, 4621.838235661803, 4657.138429390574, 4676.064787042537, 10439.269251152346, 10444.112250458644, 10499.68500944973, 10529.526171322308, 10542.683719488428, 5124.974375128175, 5152.536271735562, 5173.508516690908, 5189.3253876996505, 5195.896082078338, 4541.886452838706, 4677.345171675968, 4689.60138388234, 4704.929426058612, 4705.376645057449, 3847.480590120354, 3872.5740168581433, 3933.665638420709, 3946.072672921861, 3959.4456776051375, 1184.6150001249628, 1255.6421419895287, 1284.3321472834261, 1287.150480682745, 1288.2013151845915, 1419.7089596632666, 1438.2736717957573, 1451.8185226846645, 1455.0324034516927, 1485.8811295096582, 7803.141654418009, 7819.257170568787, 7848.0582330119605, 7858.253465920729, 7883.881741773764, 1209.9879001210052, 1223.5350566784564, 1225.307701148848, 1236.4312416288428, 1262.2552693910636, 6191.226096737908, 6306.747730090745, 6312.589681670676, 6319.462845658079, 6373.840653983688, 9880.40717556949, 10060.647877324258, 10097.0, 10208.030237127461, 10234.181265498892, 9639.759006024766, 9917.057879501435, 10026.846912605144, 10071.143952764098, 10075.042870927251, 8006.279434850891, 8070.2333278338465, 8110.188981101961, 8153.347732181412, 8159.184081591793, 7675.692972281046, 7711.768646940601, 7756.612169391621, 7778.533288002738, 7786.26030527099, 8636.913630863612, 8773.122687731176, 8795.736127916172, 8839.646414143363, 9059.864102038606, 9003.099690030944, 9266.166045055978, 9275.768105797139, 9279.76800579991, 9343.81312373735, 7384.889226661712, 7526.698932042876, 7530.058742657168, 7537.8115547111765, 7547.622618869144, 7798.844023119619, 7975.481593696391, 8022.719204827803, 8098.149694282251, 8113.0, 7177.102862142232, 7203.099612548432, 7575.734849280248, 7705.075390953121, 7890.250426209501, 7208.243134470805, 7240.782776516713, 7280.745173918887, 7336.266373362621, 7409.925900741139, 7327.523710958771, 7397.297256760599, 7411.703531858665, 7452.739154129579, 7638.388928885787, 6826.2832402599, 6858.0, 6929.7228110875, 6930.099087118642, 6942.583444993316, 7000.824979375557, 7095.361417472453, 7108.3602475777425, 7137.964310178416, 7215.494915355875], "unit": "score", "name": "mootools.html", "value": 4871.855317322588}, {"lowerIsBetter": false, "replicates": [349.76915235944267, 361.1566991075838, 361.88962366478216, 364.81212175729496, 371.53558052434465, 6308.905366419507, 6309.4636955858805, 6326.304106548282, 6337.683115844206, 6528.934710652892, 6327.145835312232, 6339.7464101436, 6341.46097581705, 6362.0, 6404.519661025419, 4895.265710143472, 4895.681780684262, 4905.705657660534, 4910.705357678551, 4914.311996320509, 4916.655834091615, 4918.901621967559, 4921.926171107436, 4930.890549626323, 4947.50524947506, 4631.39791827062, 4725.621950243973, 4756.28655701644, 4791.161546729326, 4804.90390192196, 4759.119562880844, 4794.712317260958, 4798.0643774464, 4813.566778989873, 4837.661363704542, 4225.901265670917, 4245.490541135053, 4246.490421149482, 4252.064545799919, 4254.617084462413, 6007.128966299906, 6041.0, 6059.18201042858, 6064.151018857319, 6073.0283154695035, 5548.667079975215, 5655.547556195535, 5691.288588926384, 5694.117411801178, 5694.5159661428825, 6705.932940670579, 6735.191776986793, 6735.629540375277, 6743.561668491581, 6747.460203183734, 4708.270218116198, 4715.693479923794, 4721.433427988629, 4723.126221648971, 4724.929126063112, 6806.6256355900405, 6992.5105242633035, 7050.0482434871665, 7071.116110486189, 7115.501914865909, 4761.999980004169, 4790.568848803555, 4792.257200133985, 4794.2808578713475, 4794.304825800239, 4847.95152048482, 4882.096812089775, 4893.926591101136, 4893.95106048942, 4904.583110435581, 5637.041702910433, 5644.74598643062, 5666.631668941505, 5668.2064510967675, 5668.971655141698, 6605.471562275006, 6772.72909083641, 6823.147106611674, 6825.931740682529, 6923.169219693669, 1695.4998275508754, 1722.3455087066834, 1723.3106757297182, 1723.6380360124515, 1727.576743697777, 1153.3541216918552, 1167.9416029198505, 1168.3106966889577, 1182.296533562529, 1185.3658292813304, 6473.546851720334, 6474.838129046811, 6484.157059582319, 6486.870262594722, 6492.5455218134275, 6882.0, 6913.170419549586, 6948.131483564554, 6952.409045231212, 6953.89569156463, 6307.432331090224, 6391.872162556723, 6426.132472116298, 6429.099926010363, 6446.419822215929, 3748.2128752962185, 3766.962330376716, 3780.092777733324, 3780.5085338906315, 3789.1663833956486, 7287.854242915112, 7300.56196628204, 7344.632768361561, 7373.115226172894, 7392.075990501187, 7128.144622645315, 7209.387202087776, 7214.67533960973, 7235.204127545966, 7257.310555497219, 7205.747798827016, 7228.819279517949, 7264.382527485117, 7296.197418283985, 7300.12398512182, 6991.196012458632, 7031.367176954099, 7041.753538626123, 7052.400545953651, 7068.646567671699, 6793.830154246183, 6951.304869513008, 6969.54697944632, 6976.058232138799, 6997.230304666585, 7255.310745479171, 7259.673314700745, 7265.891011634935, 7285.562866228043, 7307.378872795872, 4847.2729090636685, 4871.48849370811, 4885.2427873679635, 4885.267209918541, 4899.681520701143, 6898.586084834926, 7081.575105493687, 7081.787546373617, 7091.468139889425, 7110.395616372666, 6893.86251268535, 6898.655067246517, 6900.03399524077, 6901.206361268519, 6906.585604863724, 6715.093462382712, 6851.177858656793, 6871.965640171967, 6877.65611719422, 6879.862402752017, 6708.6310252936555, 6753.3921947025, 6753.86492270142, 6759.594424334556, 6772.695228714621, 6858.417034552119, 6893.482988775761, 6902.516823822284, 6909.792706218822, 6914.792556223321, 6464.967675161594, 6646.435053020354, 6649.0, 6714.764983225759, 6717.798466046026], "unit": "score", "name": "prototype.html", "value": 5123.481964369647}, {"lowerIsBetter": false, "replicates": [741.3698356397064, 743.2641684732114, 828.1759649149097, 924.9953750231248, 932.1796818799457, 14302.427902883897, 14382.137071775687, 14418.0, 14496.927515362422, 14582.927085364558, 14121.223332716696, 14134.575962721108, 14135.434582616708, 14233.288335583205, 14240.643983900407, 714.1109318897979, 726.415235735233, 851.0425771007616, 853.799357151069, 875.3259989807844, 816.9060558035812, 860.320346925931, 869.4305230074311, 876.5836227791812, 878.2973621103124, 868.0885070675797, 922.9446233226028, 926.6061923682408, 931.5994122527344, 931.7251410833786, 861.0786458489418, 902.1970446302796, 911.6353458616574, 913.9817203655956, 917.6375331743924, 682.1984168601873, 684.637142314574, 686.9244383117853, 688.3598253624127, 688.7004153193377, 13944.372503237379, 13959.511417100453, 14028.929855350658, 14044.648883777885, 14060.789088163685, 14119.85880141206, 14164.858351416457, 14184.148951062969, 14205.928970355082, 14276.214808185545, 10675.626353077605, 10796.5681372745, 10834.133269338434, 10835.945820270848, 11007.229493935427, 3844.6539811417106, 3877.961220387788, 3878.2437424702193, 3885.203533275672, 3913.960860391388, 48770.268445973335, 49569.0, 50044.499555004346, 50248.497515024384, 50646.24030639543, 10757.731056723644, 10846.891531084746, 10984.95642913922, 10995.890041099487, 11113.166512511432, 19629.607407851763, 19654.803451965585, 19737.210511579375, 19756.308529201408, 19756.308529201695, 7156.856862862714, 7228.96385518069, 7237.565746055254, 7411.629418529052, 7598.962005190049, 4221.303484924953, 4245.532991370947, 4257.659387249013, 4262.893427664271, 4268.509121451011, 3240.756943229267, 3260.7065364117343, 3268.2809781847955, 3273.050815263547, 3283.326917981808, 583.3087790967717, 586.9207656966255, 590.8700085981163, 594.8423667728056, 594.9464548190683, 656.0983949375399, 676.4216594811463, 683.282553319013, 715.8246229673659, 733.2484203691259, 8906.55467226636, 9220.124088211609, 9290.907090929139, 9294.256459483226, 9465.290103242147, 654.8493846415352, 742.9888551671729, 749.975067318243, 750.2834792772998, 788.42051092447, 4377.255866502702, 4469.642428605704, 4605.470370907322, 4658.138244424792, 4997.200447928314, 59676.70161649251, 59719.70140149271, 60253.69873150606, 60649.0, 60676.0, 51455.485445145816, 53101.2034819478, 54022.45977540253, 54137.45862541403, 54157.0, 47132.764336178785, 49363.0, 49544.50455495471, 50127.49872501228, 50485.0, 9628.75928101775, 9672.468014259282, 9858.211343092678, 9918.801623967336, 10041.598336066476, 37120.814395927846, 37926.24147516979, 38246.0, 38457.23085538218, 38633.03417414587, 44985.0, 45101.77449112733, 47224.2916356248, 48197.51802481931, 48294.27558586694, 12171.634850954486, 12532.686682833002, 12597.87402125967, 12660.17708848922, 12799.0, 12942.741145177231, 13531.188128712309, 13715.931420343233, 13722.588322350346, 13926.51257205993, 12321.199122057038, 12953.870461295266, 13116.475340986253, 13145.53990610324, 13151.671208219488, 11720.824187637363, 12179.0, 12196.085293603193, 12200.206986545845, 12743.044271679846, 11395.145364097893, 11875.049996000127, 12164.635060948185, 12611.621651350475, 12836.0, 10217.642382516577, 10296.227782916461, 10672.466376680979, 10684.89315106839, 10875.782484350111, 10838.945805270923, 10992.010719035005, 11346.111697782395, 11365.0, 11404.429778510876], "unit": "score", "name": "yui.html", "value": 6782.257829700449}], "name": "dromaeo_css", "value": 7318.434172768899}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 106.0, 111.0, 110.0, 111.0, 125.0, 110.0, 109.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [149.0, 126.0, 148.0, 171.0, 128.0, 152.0, 154.0, 123.0, 161.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 144.0}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 160.0, 163.0, 161.0, 161.0, 161.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 75.0, 157.0, 76.0, 75.0, 73.0, 76.0, 154.0, 72.0], "unit": "score", "name": "audio-fft", "value": 90.5}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 149.0, 95.0, 96.0, 95.0, 137.0, 96.0, 95.0, 139.0], "unit": "score", "name": "audio-oscillator", "value": 109.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 111.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.6}, {"lowerIsBetter": true, "replicates": [52.0, 56.0, 57.0, 55.0, 55.0, 55.0, 56.0, 57.0, 53.0, 55.0], "unit": "score", "name": "json-parse-financial", "value": 55.1}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 65.0, 66.0, 64.0, 64.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.7}, {"lowerIsBetter": true, "replicates": [77.0, 80.0, 80.0, 81.0, 87.0, 80.0, 87.0, 79.0, 80.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 81.2}, {"lowerIsBetter": true, "replicates": [128.0, 110.0, 115.0, 114.0, 121.0, 115.0, 111.0, 129.0, 122.0, 114.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [138.0, 134.0, 132.0, 125.0, 125.0, 122.0, 144.0, 140.0, 127.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 132.2}, {"lowerIsBetter": true, "replicates": [66.0, 66.0, 68.0, 65.0, 68.0, 67.0, 64.0, 64.0, 66.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.9}], "name": "kraken", "value": 1487.2000000000003}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.41704110500916], "unit": "score", "name": "Richards", "value": 212.1297179999999}, {"lowerIsBetter": false, "replicates": [170.1837985023826], "unit": "score", "name": "DeltaBlue", "value": 388.5093679999998}, {"lowerIsBetter": false, "replicates": [277.77777777777777], "unit": "score", "name": "Encrypt", "value": 958.2516000000002}, {"lowerIsBetter": false, "replicates": [5240.837696335078], "unit": "score", "name": "Decrypt", "value": 50.78978121878119}, {"lowerIsBetter": false, "replicates": [951.4747859181732], "unit": "score", "name": "RayTrace", "value": 777.728439}, {"lowerIsBetter": false, "replicates": [549.7526113249038], "unit": "score", "name": "Earley", "value": 1212.296197}, {"lowerIsBetter": false, "replicates": [11177.777777777777], "unit": "score", "name": "Boyer", "value": 59.6239264413519}, {"lowerIsBetter": false, "replicates": [39211.53846153846], "unit": "score", "name": "RegExp", "value": 23.232574791564506}, {"lowerIsBetter": false, "replicates": [521.376433785193], "unit": "score", "name": "Splay", "value": 156.29973800000002}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 22000.740401419742}]} 04:07:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22000.74"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1487.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7318.43"}}} 04:07:03 INFO - Return code: 0 04:07:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 04:07:03 INFO - # TBPL SUCCESS # 04:07:03 INFO - Running post-action listener: _resource_record_post_action 04:07:03 INFO - Running post-run listener: _resource_record_post_run 04:07:04 INFO - Total resource usage - Wall time: 1226s; CPU: 13.0%; Read bytes: 290816; Write bytes: 502136832; Read time: 724; Write time: 368184 04:07:04 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 241573888; Read time: 580; Write time: 189956 04:07:04 INFO - run-tests - Wall time: 1211s; CPU: 13.0%; Read bytes: 286720; Write bytes: 259964928; Read time: 144; Write time: 178228 04:07:04 INFO - Running post-run listener: _upload_blobber_files 04:07:04 INFO - Blob upload gear active. 04:07:04 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 04:07:04 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 04:07:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 04:07:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 04:07:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:07:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:07:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:06 INFO - (blobuploader) - INFO - Done attempting. 04:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:07:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:07:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:07:06 INFO - (blobuploader) - INFO - Done attempting. 04:07:06 INFO - (blobuploader) - INFO - Iteration through files over. 04:07:06 INFO - Return code: 0 04:07:06 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 04:07:06 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 04:07:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e789c3c0cee0822dcb84574a037882ae1c1164add7ee63f25cf89d86305a5d5df152724405570fe3d993d1b74fdb684d6c94d5b4c581b8fd3cbc5317ad355401", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91aed56b2c7f0920e08910e3a1bb02584f350cfbfc925c7a82532e240aa4bffb41430342dbc86bd967ed00119f222eff2711136643898b3a561ea700341e679c"} 04:07:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 04:07:06 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 04:07:06 INFO - Contents: 04:07:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e789c3c0cee0822dcb84574a037882ae1c1164add7ee63f25cf89d86305a5d5df152724405570fe3d993d1b74fdb684d6c94d5b4c581b8fd3cbc5317ad355401", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91aed56b2c7f0920e08910e3a1bb02584f350cfbfc925c7a82532e240aa4bffb41430342dbc86bd967ed00119f222eff2711136643898b3a561ea700341e679c"} 04:07:06 INFO - Running post-run listener: copy_logs_to_upload_dir 04:07:06 INFO - Copying logs to upload dir... 04:07:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 04:07:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.687583 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-03-01 04:07:06.771724) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:07:06.775498) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224 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-Aurora/sha512/e789c3c0cee0822dcb84574a037882ae1c1164add7ee63f25cf89d86305a5d5df152724405570fe3d993d1b74fdb684d6c94d5b4c581b8fd3cbc5317ad355401", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91aed56b2c7f0920e08910e3a1bb02584f350cfbfc925c7a82532e240aa4bffb41430342dbc86bd967ed00119f222eff2711136643898b3a561ea700341e679c"} build_url:https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011312 build_url: 'https://queue.taskcluster.net/v1/task/L-qZyre9SkmKmhS4HjJE8w/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e789c3c0cee0822dcb84574a037882ae1c1164add7ee63f25cf89d86305a5d5df152724405570fe3d993d1b74fdb684d6c94d5b4c581b8fd3cbc5317ad355401", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/91aed56b2c7f0920e08910e3a1bb02584f350cfbfc925c7a82532e240aa4bffb41430342dbc86bd967ed00119f222eff2711136643898b3a561ea700341e679c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-01 04:07:06.800920) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:07:06.801255) ========= 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=aa08bb06ff6271ef470a76a4000001be-1456830038.277255-69180224 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004407 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-01 04:07:06.885674) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:07:06.885993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-01 04:07:06.886277) ========= ========= Total master_lag: 0.25 =========