builder: b2g-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-037 starttime: 1453445472.9 results: success (0) buildid: 20160121203210 builduid: 02f4e01211fb48c283c08de6107e96c0 revision: 9f42d92f870561be92409b819aa3ab36e3e91950 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.896715) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.897293) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.897659) ========= 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-1453442800.921636-1613417998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.006326 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.921816) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.922168) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.935922) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.936345) ========= 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-1453442800.921636-1613417998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.986852) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.987278) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.987810) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:12.988357) ========= 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-1453442800.921636-1613417998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-01-21 22:51:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 13.0M=0.001s 2016-01-21 22:51:13 (13.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.178373 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:13.180764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:13.181146) ========= 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-1453442800.921636-1613417998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015188 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:13.232111) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-01-21 22:51:13.232612) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9f42d92f870561be92409b819aa3ab36e3e91950 --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 9f42d92f870561be92409b819aa3ab36e3e91950 --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-1453442800.921636-1613417998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-01-21 22:51:13,571 truncating revision to first 12 chars 2016-01-21 22:51:13,571 Setting DEBUG logging. 2016-01-21 22:51:13,571 attempt 1/10 2016-01-21 22:51:13,571 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/9f42d92f8705?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-01-21 22:51:13,798 unpacking tar archive at: b2g-inbound-9f42d92f8705/testing/mozharness/ program finished with exit code 0 elapsedTime=0.528758 ========= master_lag: 2.61 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 3 secs) (at 2016-01-21 22:51:16.371465) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:16.371899) ========= echo 9f42d92f870561be92409b819aa3ab36e3e91950 in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'9f42d92f870561be92409b819aa3ab36e3e91950'] 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-1453442800.921636-1613417998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 9f42d92f870561be92409b819aa3ab36e3e91950 program finished with exit code 0 elapsedTime=0.004691 script_repo_revision: '9f42d92f870561be92409b819aa3ab36e3e91950' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:16.391631) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:16.392032) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-01-21 22:51:16.403963) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-21 22:51:16.404296) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound'] 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-1453442800.921636-1613417998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:51:16 INFO - MultiFileLogger online at 20160121 22:51:16 in /builds/slave/test-pgo 22:51:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound 22:51:16 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 22:51:16 INFO - {'append_to_log': False, 22:51:16 INFO - 'base_work_dir': '/builds/slave/test-pgo', 22:51:16 INFO - 'blob_upload_branch': 'B2G-Inbound', 22:51:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 22:51:16 INFO - 'branch': 'B2G-Inbound', 22:51:16 INFO - 'buildbot_json_path': 'buildprops.json', 22:51:16 INFO - 'config_files': ('talos/linux_config.py',), 22:51:16 INFO - 'default_actions': ('clobber', 22:51:16 INFO - 'read-buildbot-config', 22:51:16 INFO - 'download-and-extract', 22:51:16 INFO - 'populate-webroot', 22:51:16 INFO - 'create-virtualenv', 22:51:16 INFO - 'install', 22:51:16 INFO - 'run-tests'), 22:51:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:51:16 INFO - 'download_minidump_stackwalk': True, 22:51:16 INFO - 'download_symbols': 'ondemand', 22:51:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:51:16 INFO - 'tooltool.py': '/tools/tooltool.py', 22:51:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:51:16 INFO - '/tools/misc-python/virtualenv.py')}, 22:51:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:51:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:51:16 INFO - 'installer_path': 'installer.exe', 22:51:16 INFO - 'log_level': 'info', 22:51:16 INFO - 'log_name': 'talos', 22:51:16 INFO - 'log_to_console': True, 22:51:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:51:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:51:16 INFO - 'opt_config_files': (), 22:51:16 INFO - 'pip_index': False, 22:51:16 INFO - 'sps_profile': False, 22:51:16 INFO - 'sps_profile_interval': 0, 22:51:16 INFO - 'suite': 'dromaeojs', 22:51:16 INFO - 'system_bits': '32', 22:51:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:51:16 INFO - 'title': 'talos-linux64-ix-037', 22:51:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:51:16 INFO - 'use_talos_json': True, 22:51:16 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 22:51:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:51:16 INFO - 'work_dir': 'build'} 22:51:16 INFO - ##### 22:51:16 INFO - ##### Running clobber step. 22:51:16 INFO - ##### 22:51:16 INFO - Running pre-action listener: _resource_record_pre_action 22:51:16 INFO - Running main action method: clobber 22:51:16 INFO - rmtree: /builds/slave/test-pgo/build 22:51:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 22:51:17 INFO - Running post-action listener: _resource_record_post_action 22:51:17 INFO - ##### 22:51:17 INFO - ##### Running read-buildbot-config step. 22:51:17 INFO - ##### 22:51:17 INFO - Running pre-action listener: _resource_record_pre_action 22:51:17 INFO - Running main action method: read_buildbot_config 22:51:17 INFO - Using buildbot properties: 22:51:17 INFO - { 22:51:17 INFO - "project": "", 22:51:17 INFO - "product": "firefox", 22:51:17 INFO - "script_repo_revision": "production", 22:51:17 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:51:17 INFO - "repository": "", 22:51:17 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound pgo talos dromaeojs", 22:51:17 INFO - "buildid": "20160121203210", 22:51:17 INFO - "pgo_build": "True", 22:51:17 INFO - "basedir": "/builds/slave/test-pgo", 22:51:17 INFO - "buildnumber": 225, 22:51:17 INFO - "slavename": "talos-linux64-ix-037", 22:51:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:51:17 INFO - "platform": "ubuntu64_hw", 22:51:17 INFO - "scheduler": "tests-b2g-inbound-linux64-pgo-talos", 22:51:17 INFO - "branch": "b2g-inbound", 22:51:17 INFO - "repo_path": "integration/b2g-inbound", 22:51:17 INFO - "revision": "9f42d92f870561be92409b819aa3ab36e3e91950", 22:51:17 INFO - "stage_platform": "linux64-pgo", 22:51:17 INFO - "builduid": "02f4e01211fb48c283c08de6107e96c0", 22:51:17 INFO - "slavebuilddir": "test" 22:51:17 INFO - } 22:51:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 22:51:17 INFO - Running post-action listener: _resource_record_post_action 22:51:17 INFO - ##### 22:51:17 INFO - ##### Running download-and-extract step. 22:51:17 INFO - ##### 22:51:17 INFO - Running pre-action listener: _resource_record_pre_action 22:51:17 INFO - Running main action method: download_and_extract 22:51:17 INFO - mkdir: /builds/slave/test-pgo/build/tests 22:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:17 INFO - https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/test_packages.json 22:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/test_packages.json 22:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 22:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 22:51:17 INFO - Downloaded 1448 bytes. 22:51:17 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 22:51:17 INFO - Using the following test package requirements: 22:51:17 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:51:17 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:51:17 INFO - u'gtest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:51:17 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:17 INFO - u'jsshell-linux-x86_64.zip'], 22:51:17 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:51:17 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:51:17 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:51:17 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:51:17 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:51:17 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 22:51:17 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 22:51:17 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:51:17 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:51:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:17 INFO - https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:51:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:51:19 INFO - Downloaded 22486909 bytes. 22:51:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:51:19 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:51:20 INFO - Return code: 0 22:51:20 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:51:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:20 INFO - https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:51:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 22:51:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:51:22 INFO - Downloaded 22486909 bytes. 22:51:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:51:22 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 22:51:23 INFO - Return code: 0 22:51:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:23 INFO - https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:51:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:51:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:51:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 22:51:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:51:25 INFO - Downloaded 10706572 bytes. 22:51:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 22:51:25 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 22:51:25 INFO - Return code: 0 22:51:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:25 INFO - https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:51:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:51:27 INFO - Downloaded 55977083 bytes. 22:51:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:27 INFO - mkdir: /builds/slave/test-pgo/properties 22:51:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 22:51:27 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 22:51:27 INFO - Contents: 22:51:27 INFO - build_url:https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 22:51:27 INFO - Running post-action listener: _resource_record_post_action 22:51:27 INFO - Running post-action listener: set_extra_try_arguments 22:51:27 INFO - ##### 22:51:27 INFO - ##### Running populate-webroot step. 22:51:27 INFO - ##### 22:51:27 INFO - Running pre-action listener: _resource_record_pre_action 22:51:27 INFO - Running main action method: populate_webroot 22:51:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:51:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:51:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:51:27 INFO - '--tppagecycles', 22:51:27 INFO - '7'], 22:51:27 INFO - 'tests': ['tsvgm']}}, 22:51:27 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:51:27 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:51:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:51:27 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:51:27 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:51:27 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:51:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:27 INFO - 'talos_options': ['--e10s'], 22:51:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:51:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:27 INFO - 'tests': ['damp', 'tps']}, 22:51:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:27 INFO - 'talos_options': ['--e10s'], 22:51:27 INFO - 'tests': ['damp', 'tps']}, 22:51:27 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:51:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:51:27 INFO - 'other': {'tests': ['a11yr', 22:51:27 INFO - 'ts_paint', 22:51:27 INFO - 'tpaint', 22:51:27 INFO - 'sessionrestore', 22:51:27 INFO - 'sessionrestore_no_auto_restore']}, 22:51:27 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:51:27 INFO - 'tests': ['a11yr', 22:51:27 INFO - 'ts_paint', 22:51:27 INFO - 'tpaint', 22:51:27 INFO - 'sessionrestore', 22:51:27 INFO - 'sessionrestore_no_auto_restore']}, 22:51:27 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:51:27 INFO - 'tests': ['a11yr', 22:51:27 INFO - 'ts_paint', 22:51:27 INFO - 'tpaint', 22:51:27 INFO - 'sessionrestore', 22:51:27 INFO - 'sessionrestore_no_auto_restore']}, 22:51:27 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:51:27 INFO - 'tests': ['a11yr', 22:51:27 INFO - 'ts_paint', 22:51:27 INFO - 'tpaint', 22:51:27 INFO - 'sessionrestore', 22:51:27 INFO - 'sessionrestore_no_auto_restore']}, 22:51:27 INFO - 'other_l64': {'tests': ['a11yr', 22:51:27 INFO - 'ts_paint', 22:51:27 INFO - 'tpaint', 22:51:27 INFO - 'sessionrestore', 22:51:27 INFO - 'sessionrestore_no_auto_restore']}, 22:51:27 INFO - 'other_nol64': {'tests': ['a11yr', 22:51:27 INFO - 'ts_paint', 22:51:27 INFO - 'tpaint', 22:51:27 INFO - 'sessionrestore', 22:51:27 INFO - 'sessionrestore_no_auto_restore']}, 22:51:27 INFO - 'svgr': {'tests': ['tsvgx', 22:51:27 INFO - 'tsvgr_opacity', 22:51:27 INFO - 'tart', 22:51:27 INFO - 'tscrollx', 22:51:27 INFO - 'cart']}, 22:51:27 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:51:27 INFO - 'tests': ['tsvgx', 22:51:27 INFO - 'tsvgr_opacity', 22:51:27 INFO - 'tart', 22:51:27 INFO - 'tscrollx', 22:51:27 INFO - 'cart']}, 22:51:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:27 INFO - 'tests': ['tp5o']}, 22:51:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:27 INFO - 'talos_options': ['--e10s'], 22:51:27 INFO - 'tests': ['tp5o']}, 22:51:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:27 INFO - 'talos_options': ['--xperf_path', 22:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:27 INFO - 'tests': ['tp5n']}, 22:51:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:51:27 INFO - 'talos_options': ['--e10s', 22:51:27 INFO - '--xperf_path', 22:51:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:51:27 INFO - 'tests': ['tp5n']}}, 22:51:27 INFO - 'talos.zip': {'path': '', 22:51:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:51:27 INFO - Running post-action listener: _resource_record_post_action 22:51:27 INFO - ##### 22:51:27 INFO - ##### Running create-virtualenv step. 22:51:27 INFO - ##### 22:51:27 INFO - Running pre-action listener: _resource_record_pre_action 22:51:27 INFO - Running main action method: create_virtualenv 22:51:27 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 22:51:27 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 22:51:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 22:51:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:51:27 INFO - Using real prefix '/usr' 22:51:27 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 22:51:27 INFO - Installing distribute.............................................................................................................................................................................................done. 22:51:29 INFO - Installing pip.................done. 22:51:29 INFO - Return code: 0 22:51:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 22:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:29 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 0x7f51fcce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f58630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, '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-1453442800.921636-1613417998', '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 22:51:29 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 22:51:29 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 22:51:29 INFO - Using env: {'DISPLAY': ':0', 22:51:29 INFO - 'HOME': '/home/cltbld', 22:51:29 INFO - 'LANG': 'en_US.UTF-8', 22:51:29 INFO - 'LANGUAGE': 'en_US:en', 22:51:29 INFO - 'LOGNAME': 'cltbld', 22:51:29 INFO - 'MAIL': '/var/mail/cltbld', 22:51:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:29 INFO - 'MOZ_NO_REMOTE': '1', 22:51:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:29 INFO - 'NO_EM_RESTART': '1', 22:51:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:29 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:29 INFO - 'SHELL': '/bin/bash', 22:51:29 INFO - 'SHLVL': '1', 22:51:29 INFO - 'TERM': 'linux', 22:51:29 INFO - 'TMOUT': '86400', 22:51:29 INFO - 'USER': 'cltbld', 22:51:29 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:51:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:29 INFO - '_': '/tools/buildbot/bin/python'} 22:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:30 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 22:51:30 INFO - Cleaning up... 22:51:30 INFO - Return code: 0 22:51:30 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 22:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:30 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 0x7f51fcce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f58630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, '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-1453442800.921636-1613417998', '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 22:51:30 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 22:51:30 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 22:51:30 INFO - Using env: {'DISPLAY': ':0', 22:51:30 INFO - 'HOME': '/home/cltbld', 22:51:30 INFO - 'LANG': 'en_US.UTF-8', 22:51:30 INFO - 'LANGUAGE': 'en_US:en', 22:51:30 INFO - 'LOGNAME': 'cltbld', 22:51:30 INFO - 'MAIL': '/var/mail/cltbld', 22:51:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:30 INFO - 'MOZ_NO_REMOTE': '1', 22:51:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:30 INFO - 'NO_EM_RESTART': '1', 22:51:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:30 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:30 INFO - 'SHELL': '/bin/bash', 22:51:30 INFO - 'SHLVL': '1', 22:51:30 INFO - 'TERM': 'linux', 22:51:30 INFO - 'TMOUT': '86400', 22:51:30 INFO - 'USER': 'cltbld', 22:51:30 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:51:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:30 INFO - '_': '/tools/buildbot/bin/python'} 22:51:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:30 INFO - Downloading/unpacking psutil>=0.7.1 22:51:30 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 22:51:30 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 22:51:30 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 22:51:30 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 22:51:30 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 22:51:30 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 22:51:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 22:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:32 INFO - Installing collected packages: psutil 22:51:32 INFO - Running setup.py install for psutil 22:51:32 INFO - building 'psutil._psutil_linux' extension 22:51:32 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 22:51:32 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 22:51:32 INFO - building 'psutil._psutil_posix' extension 22:51:32 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 22:51:32 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 22:51:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:51:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:51:32 INFO - Successfully installed psutil 22:51:32 INFO - Cleaning up... 22:51:32 INFO - Return code: 0 22:51:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 22:51: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')]} 22:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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', '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 0x7f51fcce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f58630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, '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-1453442800.921636-1613417998', '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 22:51: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 22:51: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 mozsystemmonitor==0.0.0 22:51:32 INFO - Using env: {'DISPLAY': ':0', 22:51:32 INFO - 'HOME': '/home/cltbld', 22:51:32 INFO - 'LANG': 'en_US.UTF-8', 22:51:32 INFO - 'LANGUAGE': 'en_US:en', 22:51:32 INFO - 'LOGNAME': 'cltbld', 22:51:32 INFO - 'MAIL': '/var/mail/cltbld', 22:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:32 INFO - 'MOZ_NO_REMOTE': '1', 22:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:32 INFO - 'NO_EM_RESTART': '1', 22:51:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:32 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:32 INFO - 'SHELL': '/bin/bash', 22:51:32 INFO - 'SHLVL': '1', 22:51:32 INFO - 'TERM': 'linux', 22:51:32 INFO - 'TMOUT': '86400', 22:51:32 INFO - 'USER': 'cltbld', 22:51:32 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:32 INFO - '_': '/tools/buildbot/bin/python'} 22:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:51:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:51:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:51:34 INFO - Installing collected packages: mozsystemmonitor 22:51:34 INFO - Running setup.py install for mozsystemmonitor 22:51:34 INFO - Successfully installed mozsystemmonitor 22:51:34 INFO - Cleaning up... 22:51:34 INFO - Return code: 0 22:51:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 22:51: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')]} 22:51:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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')]} 22:51:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51: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', '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 0x7f51fcce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f58630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, '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-1453442800.921636-1613417998', '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 22:51: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', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 22:51: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 blobuploader==1.2.4 22:51:34 INFO - Using env: {'DISPLAY': ':0', 22:51:34 INFO - 'HOME': '/home/cltbld', 22:51:34 INFO - 'LANG': 'en_US.UTF-8', 22:51:34 INFO - 'LANGUAGE': 'en_US:en', 22:51:34 INFO - 'LOGNAME': 'cltbld', 22:51:34 INFO - 'MAIL': '/var/mail/cltbld', 22:51:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:34 INFO - 'MOZ_NO_REMOTE': '1', 22:51:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:34 INFO - 'NO_EM_RESTART': '1', 22:51:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:34 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:34 INFO - 'SHELL': '/bin/bash', 22:51:34 INFO - 'SHLVL': '1', 22:51:34 INFO - 'TERM': 'linux', 22:51:34 INFO - 'TMOUT': '86400', 22:51:34 INFO - 'USER': 'cltbld', 22:51:34 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:51:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:34 INFO - '_': '/tools/buildbot/bin/python'} 22:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:35 INFO - Downloading/unpacking blobuploader==1.2.4 22:51:35 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 22:51:35 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 22:51:35 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 22:51:35 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 22:51:35 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 22:51:35 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 22:51:36 INFO - Downloading blobuploader-1.2.4.tar.gz 22:51:36 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:51:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51: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 22:51:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 22:51:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:51:37 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 22:51:37 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 22:51:37 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 22:51:37 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 22:51:37 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 22:51:37 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 22:51:37 INFO - Downloading docopt-0.6.1.tar.gz 22:51:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 22:51:37 INFO - Installing collected packages: blobuploader, requests, docopt 22:51:37 INFO - Running setup.py install for blobuploader 22:51:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:51:37 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 22:51:37 INFO - Running setup.py install for requests 22:51:38 INFO - Running setup.py install for docopt 22:51:38 INFO - Successfully installed blobuploader requests docopt 22:51:38 INFO - Cleaning up... 22:51:38 INFO - Return code: 0 22:51:38 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:38 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 0x7f51fcce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f58630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, '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-1453442800.921636-1613417998', '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 22:51:38 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 22:51:38 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 22:51:38 INFO - Using env: {'DISPLAY': ':0', 22:51:38 INFO - 'HOME': '/home/cltbld', 22:51:38 INFO - 'LANG': 'en_US.UTF-8', 22:51:38 INFO - 'LANGUAGE': 'en_US:en', 22:51:38 INFO - 'LOGNAME': 'cltbld', 22:51:38 INFO - 'MAIL': '/var/mail/cltbld', 22:51:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:38 INFO - 'MOZ_NO_REMOTE': '1', 22:51:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:38 INFO - 'NO_EM_RESTART': '1', 22:51:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:38 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:38 INFO - 'SHELL': '/bin/bash', 22:51:38 INFO - 'SHLVL': '1', 22:51:38 INFO - 'TERM': 'linux', 22:51:38 INFO - 'TMOUT': '86400', 22:51:38 INFO - 'USER': 'cltbld', 22:51:38 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:51:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:38 INFO - '_': '/tools/buildbot/bin/python'} 22:51:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:38 INFO - Running setup.py (path:/tmp/pip-1rETpb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:38 INFO - Running setup.py (path:/tmp/pip-ArVZeS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:38 INFO - Running setup.py (path:/tmp/pip-6uIA0P-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:38 INFO - Running setup.py (path:/tmp/pip-pjI3Z2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:38 INFO - Running setup.py (path:/tmp/pip-3BIt5W-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:38 INFO - Running setup.py (path:/tmp/pip-BK5Dsg-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:38 INFO - Running setup.py (path:/tmp/pip-NHEbV8-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:38 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:38 INFO - Running setup.py (path:/tmp/pip-CW_dyj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:39 INFO - Running setup.py (path:/tmp/pip-2j7BnC-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:39 INFO - Running setup.py (path:/tmp/pip-Zxz4E5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:39 INFO - Running setup.py (path:/tmp/pip-qEhqh4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:39 INFO - Running setup.py (path:/tmp/pip-Rp4X1z-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:39 INFO - Running setup.py (path:/tmp/pip-twWLBA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:39 INFO - Running setup.py (path:/tmp/pip-p95k05-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:39 INFO - Running setup.py (path:/tmp/pip-HEWzH4-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:39 INFO - Running setup.py (path:/tmp/pip-KKeI1N-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:39 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:39 INFO - Running setup.py (path:/tmp/pip-UX6hLM-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:51:39 INFO - Running setup.py install for manifestparser 22:51:39 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 22:51:39 INFO - Running setup.py install for mozcrash 22:51:39 INFO - Running setup.py install for mozdebug 22:51:39 INFO - Running setup.py install for mozdevice 22:51:40 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Running setup.py install for mozfile 22:51:40 INFO - Running setup.py install for mozhttpd 22:51:40 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Running setup.py install for mozinfo 22:51:40 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Running setup.py install for mozInstall 22:51:40 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Running setup.py install for mozleak 22:51:40 INFO - Running setup.py install for mozlog 22:51:40 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Running setup.py install for moznetwork 22:51:40 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 22:51:40 INFO - Running setup.py install for mozprocess 22:51:40 INFO - Running setup.py install for mozprofile 22:51:41 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 22:51:41 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 22:51:41 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 22:51:41 INFO - Running setup.py install for mozrunner 22:51:41 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 22:51:41 INFO - Running setup.py install for mozscreenshot 22:51:41 INFO - Running setup.py install for moztest 22:51:41 INFO - Running setup.py install for mozversion 22:51:41 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 22:51:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:51:41 INFO - Cleaning up... 22:51:41 INFO - Return code: 0 22:51:41 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:51:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:41 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 0x7f51fcce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f58630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, '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-1453442800.921636-1613417998', '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 22:51:41 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 22:51:41 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 22:51:41 INFO - Using env: {'DISPLAY': ':0', 22:51:41 INFO - 'HOME': '/home/cltbld', 22:51:41 INFO - 'LANG': 'en_US.UTF-8', 22:51:41 INFO - 'LANGUAGE': 'en_US:en', 22:51:41 INFO - 'LOGNAME': 'cltbld', 22:51:41 INFO - 'MAIL': '/var/mail/cltbld', 22:51:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:41 INFO - 'MOZ_NO_REMOTE': '1', 22:51:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:41 INFO - 'NO_EM_RESTART': '1', 22:51:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:41 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:41 INFO - 'SHELL': '/bin/bash', 22:51:41 INFO - 'SHLVL': '1', 22:51:41 INFO - 'TERM': 'linux', 22:51:41 INFO - 'TMOUT': '86400', 22:51:41 INFO - 'USER': 'cltbld', 22:51:41 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:51:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:41 INFO - '_': '/tools/buildbot/bin/python'} 22:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:41 INFO - Running setup.py (path:/tmp/pip-cJqOkx-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 22:51:41 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)) 22:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:41 INFO - Running setup.py (path:/tmp/pip-Sgm3WD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 22:51:41 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)) 22:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:41 INFO - Running setup.py (path:/tmp/pip-MnU1pA-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 22:51:41 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)) 22:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:41 INFO - Running setup.py (path:/tmp/pip-q6BWEu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 22:51:41 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)) 22:51:41 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:41 INFO - Running setup.py (path:/tmp/pip-DGg2lU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:42 INFO - Running setup.py (path:/tmp/pip-fyMx_x-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:42 INFO - Running setup.py (path:/tmp/pip-ammfJX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:42 INFO - Running setup.py (path:/tmp/pip-vB4ckm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:42 INFO - Running setup.py (path:/tmp/pip-diL4dI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:42 INFO - Running setup.py (path:/tmp/pip-jgXdEl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:42 INFO - Running setup.py (path:/tmp/pip-uMtYF9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:42 INFO - Running setup.py (path:/tmp/pip-3WOgVI-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:42 INFO - Running setup.py (path:/tmp/pip-ioZfh7-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:42 INFO - Running setup.py (path:/tmp/pip-S_3QpU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:42 INFO - Running setup.py (path:/tmp/pip-VcNcnb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:42 INFO - Running setup.py (path:/tmp/pip-T22vxa-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 22:51:42 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)) 22:51:42 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:42 INFO - Running setup.py (path:/tmp/pip-_yNHxV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 22:51:42 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)) 22:51:42 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)) 22:51:42 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)) 22:51:42 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)) 22:51:42 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)) 22:51:42 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)) 22:51:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 22:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:44 INFO - Downloading blessings-1.6.tar.gz 22:51:44 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 22:51:44 INFO - Installing collected packages: blessings 22:51:44 INFO - Running setup.py install for blessings 22:51:44 INFO - Successfully installed blessings 22:51:44 INFO - Cleaning up... 22:51:44 INFO - Return code: 0 22:51:44 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 22:51:44 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:51:44 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:51:45 INFO - Reading from file tmpfile_stdout 22:51:45 INFO - Current package versions: 22:51:45 INFO - argparse == 1.2.1 22:51:45 INFO - blessings == 1.6 22:51:45 INFO - blobuploader == 1.2.4 22:51:45 INFO - docopt == 0.6.1 22:51:45 INFO - manifestparser == 1.1 22:51:45 INFO - mozInstall == 1.12 22:51:45 INFO - mozcrash == 0.16 22:51:45 INFO - mozdebug == 0.1 22:51:45 INFO - mozdevice == 0.48 22:51:45 INFO - mozfile == 1.2 22:51:45 INFO - mozhttpd == 0.7 22:51:45 INFO - mozinfo == 0.9 22:51:45 INFO - mozleak == 0.1 22:51:45 INFO - mozlog == 3.1 22:51:45 INFO - moznetwork == 0.27 22:51:45 INFO - mozprocess == 0.22 22:51:45 INFO - mozprofile == 0.28 22:51:45 INFO - mozrunner == 6.11 22:51:45 INFO - mozscreenshot == 0.1 22:51:45 INFO - mozsystemmonitor == 0.0 22:51:45 INFO - moztest == 0.7 22:51:45 INFO - mozversion == 1.4 22:51:45 INFO - psutil == 3.1.1 22:51:45 INFO - requests == 1.2.3 22:51:45 INFO - wsgiref == 0.1.2 22:51:45 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 22:51:45 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')]} 22:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:45 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')]} 22:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:45 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 0x7f51fcce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f58630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, '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-1453442800.921636-1613417998', '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 22:51:45 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 22:51:45 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 22:51:45 INFO - Using env: {'DISPLAY': ':0', 22:51:45 INFO - 'HOME': '/home/cltbld', 22:51:45 INFO - 'LANG': 'en_US.UTF-8', 22:51:45 INFO - 'LANGUAGE': 'en_US:en', 22:51:45 INFO - 'LOGNAME': 'cltbld', 22:51:45 INFO - 'MAIL': '/var/mail/cltbld', 22:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:45 INFO - 'MOZ_NO_REMOTE': '1', 22:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:45 INFO - 'NO_EM_RESTART': '1', 22:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:45 INFO - 'SHELL': '/bin/bash', 22:51:45 INFO - 'SHLVL': '1', 22:51:45 INFO - 'TERM': 'linux', 22:51:45 INFO - 'TMOUT': '86400', 22:51:45 INFO - 'USER': 'cltbld', 22:51:45 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:45 INFO - '_': '/tools/buildbot/bin/python'} 22:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:45 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)) 22:51:45 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)) 22:51:45 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)) 22:51:45 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)) 22:51:45 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)) 22:51:45 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)) 22:51:45 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)) 22:51:45 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)) 22:51:45 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)) 22:51:45 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)) 22:51:45 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)) 22:51:45 INFO - Cleaning up... 22:51:45 INFO - Return code: 0 22:51:45 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 22:51:45 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')]} 22:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:45 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')]} 22:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:45 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 0x7f51fcce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f58630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, '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-1453442800.921636-1613417998', '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 22:51:45 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 22:51:45 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 22:51:45 INFO - Using env: {'DISPLAY': ':0', 22:51:45 INFO - 'HOME': '/home/cltbld', 22:51:45 INFO - 'LANG': 'en_US.UTF-8', 22:51:45 INFO - 'LANGUAGE': 'en_US:en', 22:51:45 INFO - 'LOGNAME': 'cltbld', 22:51:45 INFO - 'MAIL': '/var/mail/cltbld', 22:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:45 INFO - 'MOZ_NO_REMOTE': '1', 22:51:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:45 INFO - 'NO_EM_RESTART': '1', 22:51:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:45 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:45 INFO - 'SHELL': '/bin/bash', 22:51:45 INFO - 'SHLVL': '1', 22:51:45 INFO - 'TERM': 'linux', 22:51:45 INFO - 'TMOUT': '86400', 22:51:45 INFO - 'USER': 'cltbld', 22:51:45 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:45 INFO - '_': '/tools/buildbot/bin/python'} 22:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:45 INFO - Downloading/unpacking jsonschema 22:51:45 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 22:51:45 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 22:51:45 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 22:51:45 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 22:51:45 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 22:51:45 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 22:51:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:51:47 INFO - Downloading/unpacking functools32 (from jsonschema) 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 INFO - Downloading functools32-3.2.3-2.tar.gz 22:51:47 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 22:51:47 INFO - warning: no files found matching '*.txt' 22:51:47 INFO - no previously-included directories found matching 'build' 22:51:47 INFO - no previously-included directories found matching 'dist' 22:51:47 INFO - no previously-included directories found matching '.git*' 22:51:47 INFO - Installing collected packages: jsonschema, functools32 22:51:47 INFO - Running setup.py install for functools32 22:51:47 INFO - warning: no files found matching '*.txt' 22:51:47 INFO - no previously-included directories found matching 'build' 22:51:47 INFO - no previously-included directories found matching 'dist' 22:51:47 INFO - no previously-included directories found matching '.git*' 22:51:47 INFO - Successfully installed jsonschema functools32 22:51:47 INFO - Cleaning up... 22:51:47 INFO - Return code: 0 22:51:47 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 22:51:47 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')]} 22:51:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:51:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:47 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')]} 22:51:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:51:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:51:47 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 0x7f51fcce0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e888a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1f58630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, '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-1453442800.921636-1613417998', '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 22:51:47 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 22:51:47 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 22:51:47 INFO - Using env: {'DISPLAY': ':0', 22:51:47 INFO - 'HOME': '/home/cltbld', 22:51:47 INFO - 'LANG': 'en_US.UTF-8', 22:51:47 INFO - 'LANGUAGE': 'en_US:en', 22:51:47 INFO - 'LOGNAME': 'cltbld', 22:51:47 INFO - 'MAIL': '/var/mail/cltbld', 22:51:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:51:47 INFO - 'MOZ_NO_REMOTE': '1', 22:51:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:51:47 INFO - 'NO_EM_RESTART': '1', 22:51:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:51:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:51:47 INFO - 'PWD': '/builds/slave/test-pgo', 22:51:47 INFO - 'SHELL': '/bin/bash', 22:51:47 INFO - 'SHLVL': '1', 22:51:47 INFO - 'TERM': 'linux', 22:51:47 INFO - 'TMOUT': '86400', 22:51:47 INFO - 'USER': 'cltbld', 22:51:47 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:51:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:51:47 INFO - '_': '/tools/buildbot/bin/python'} 22:51:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:51:47 INFO - Downloading/unpacking flake8 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:47 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 22:51:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:51:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:51:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:51:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:51:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:51:50 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:51:50 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 22:51:50 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 22:51:50 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 22:51:50 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 22:51:50 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 22:51:50 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 22:51:50 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 22:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:51:50 INFO - no previously-included directories found matching 'docs/_build' 22:51:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:51:50 INFO - Running setup.py install for pep8 22:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:51:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:51:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:51:50 INFO - no previously-included directories found matching 'docs/_build' 22:51:50 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 22:51:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:51:50 INFO - Cleaning up... 22:51:50 INFO - Return code: 0 22:51:50 INFO - Running post-action listener: _resource_record_post_action 22:51:50 INFO - Running post-action listener: _start_resource_monitoring 22:51:50 INFO - Starting resource monitoring. 22:51:50 INFO - ##### 22:51:50 INFO - ##### Running install step. 22:51:50 INFO - ##### 22:51:50 INFO - Running pre-action listener: _resource_record_pre_action 22:51:50 INFO - Running main action method: install 22:51:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 22:51:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 22:51:50 INFO - Reading from file tmpfile_stdout 22:51:50 INFO - Detecting whether we're running mozinstall >=1.0... 22:51:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 22:51:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 22:51:50 INFO - Reading from file tmpfile_stdout 22:51:50 INFO - Output received: 22:51:50 INFO - Usage: mozinstall [options] installer 22:51:50 INFO - Options: 22:51:50 INFO - -h, --help show this help message and exit 22:51:50 INFO - -d DEST, --destination=DEST 22:51:50 INFO - Directory to install application into. [default: 22:51:50 INFO - "/builds/slave/test-pgo"] 22:51:50 INFO - --app=APP Application being installed. [default: firefox] 22:51:50 INFO - mkdir: /builds/slave/test-pgo/build/application 22:51:50 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 22:51:50 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 22:52:07 INFO - Reading from file tmpfile_stdout 22:52:07 INFO - Output received: 22:52:07 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 22:52:07 INFO - Running post-action listener: _resource_record_post_action 22:52:07 INFO - ##### 22:52:07 INFO - ##### Running run-tests step. 22:52:07 INFO - ##### 22:52:07 INFO - Running pre-action listener: _resource_record_pre_action 22:52:07 INFO - Running main action method: run_tests 22:52:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 22:52:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 22:52:07 INFO - Python 2.7.3 22:52:07 INFO - Return code: 0 22:52:07 INFO - grabbing minidump binary from tooltool 22:52: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')]} 22:52:07 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 0x1fe9840>, '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 0x1f566b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f56b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 22:52:07 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 22:52:07 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 22:52:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:52:07 INFO - Return code: 0 22:52:07 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 22:52:07 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 22:52:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 22:52:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 22:52:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 22:52:07 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 22:52:07 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 22:52:08 INFO - Return code: 0 22:52:08 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.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_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test-pgo/build 22:52:08 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName B2G-Inbound --suite dromaeojs --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.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_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log 22:52:08 INFO - Using env: {'DISPLAY': ':0', 22:52:08 INFO - 'HOME': '/home/cltbld', 22:52:08 INFO - 'LANG': 'en_US.UTF-8', 22:52:08 INFO - 'LANGUAGE': 'en_US:en', 22:52:08 INFO - 'LOGNAME': 'cltbld', 22:52:08 INFO - 'MAIL': '/var/mail/cltbld', 22:52:08 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:52:08 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 22:52:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:52:08 INFO - 'MOZ_NO_REMOTE': '1', 22:52:08 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 22:52:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:52:08 INFO - 'NO_EM_RESTART': '1', 22:52:08 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:52:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 22:52:08 INFO - 'PWD': '/builds/slave/test-pgo', 22:52:08 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 22:52:08 INFO - 'SHELL': '/bin/bash', 22:52:08 INFO - 'SHLVL': '1', 22:52:08 INFO - 'TERM': 'linux', 22:52:08 INFO - 'TMOUT': '86400', 22:52:08 INFO - 'USER': 'cltbld', 22:52:08 INFO - 'XDG_SESSION_COOKIE': 'aa08bb06ff6271ef470a76a4000001be-1453442800.921636-1613417998', 22:52:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:52:08 INFO - '_': '/tools/buildbot/bin/python'} 22:52:08 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'B2G-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.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_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 22:52:08 INFO - mozversion application_buildid: 20160121203210 22:52:08 INFO - mozversion application_changeset: 9f42d92f870561be92409b819aa3ab36e3e91950 22:52:08 INFO - mozversion application_display_name: Nightly 22:52:08 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:52:08 INFO - mozversion application_name: Firefox 22:52:08 INFO - mozversion application_remotingname: firefox 22:52:08 INFO - mozversion application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:52:08 INFO - mozversion application_vendor: Mozilla 22:52:08 INFO - mozversion application_version: 46.0a1 22:52:08 INFO - mozversion platform_buildid: 20160121203210 22:52:08 INFO - mozversion platform_changeset: 9f42d92f870561be92409b819aa3ab36e3e91950 22:52:08 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:52:08 INFO - mozversion platform_version: 46.0a1 22:52:08 INFO - using testdate: 1453445528 22:52:08 INFO - actual date: 1453445528 22:52:08 INFO - starting webserver on 'localhost:36518' 22:52:08 INFO - SUITE-START | Running 3 tests 22:52:08 INFO - TEST-START | dromaeo_css 22:52:08 INFO - operating with platform_type : linux_ 22:52:08 INFO - Initialising browser for dromaeo_css test... 22:52:08 INFO - TEST-INFO | started process 28373 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSuXbYE/profile http://localhost:36518/getInfo.html) 22:52:12 INFO - PROCESS | 28373 | __metrics Screen width/height:1600/1200 22:52:12 INFO - PROCESS | 28373 | colorDepth:24 22:52:12 INFO - PROCESS | 28373 | Browser inner width/height: 1024/697 22:52:12 INFO - PROCESS | 28373 | __metrics 22:52:12 INFO - PROCESS | 28373 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 22:52:12 INFO - PROCESS | 28373 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:52:13 INFO - TEST-INFO | 28373: exit 0 22:52:13 INFO - Browser initialized. 22:52:13 INFO - Running cycle 1/1 for dromaeo_css test... 22:52:13 INFO - TEST-INFO | started process 28463 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpSuXbYE/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:52:25 INFO - PROCESS | 28463 | RSS: Main: 149688320 22:52:25 INFO - PROCESS | 28463 | 22:53:16 INFO - PROCESS | 28463 | 1453445596968 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] 22:55:25 INFO - PROCESS | 28463 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36518/tests/dromaeo/cssquery-ext.html) 22:55:26 INFO - PROCESS | 28463 | RSS: Main: 262033408 22:55:26 INFO - PROCESS | 28463 | 22:58:28 INFO - PROCESS | 28463 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-ext.html (next: http://localhost:36518/tests/dromaeo/cssquery-jquery.html) 22:58:29 INFO - PROCESS | 28463 | RSS: Main: 239771648 22:58:29 INFO - PROCESS | 28463 | 23:01:31 INFO - PROCESS | 28463 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36518/tests/dromaeo/cssquery-mootools.html) 23:01:32 INFO - PROCESS | 28463 | RSS: Main: 228876288 23:01:32 INFO - PROCESS | 28463 | 23:04:33 INFO - PROCESS | 28463 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36518/tests/dromaeo/cssquery-prototype.html) 23:04:34 INFO - PROCESS | 28463 | RSS: Main: 216993792 23:04:34 INFO - PROCESS | 28463 | 23:07:37 INFO - PROCESS | 28463 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36518/tests/dromaeo/cssquery-yui.html) 23:07:37 INFO - PROCESS | 28463 | RSS: Main: 217116672 23:07:37 INFO - PROCESS | 28463 | 23:10:40 INFO - PROCESS | 28463 | Cycle 1(1): loaded http://localhost:36518/tests/dromaeo/cssquery-yui.html (next: http://localhost:36518/tests/dromaeo/cssquery-dojo.html) 23:10:40 INFO - PROCESS | 28463 | RSS: Main: 285646848 23:10:40 INFO - PROCESS | 28463 | 23:10:40 INFO - PROCESS | 28463 | __start_tp_report 23:10:40 INFO - PROCESS | 28463 | _x_x_mozilla_page_load 23:10:40 INFO - PROCESS | 28463 | _x_x_mozilla_page_load_details 23:10:40 INFO - PROCESS | 28463 | |i|pagename|runs| 23:10:40 INFO - PROCESS | 28463 | |0;dojo.html;3082.306481041765;3127.280725433152;3135.655077941426;3173.111528771943;3202.4075546023987;4921.926171107436;5060.949390506094;5088.109580823355;5090.261912022755;5127.820526281581;5072.898542029157;5177.896442071156;5260.263563101169;5262.263283140353;5273.34083239595;4661.510541393156;4691.179043667345;4700.623950083985;4719.882002949919;4753.786079626408;4381.189479946204;4739.099571081483;4808.591269742059;4810.951890481103;4847.684900481475;4648.558386953234;4716.316134160562;4762.309465127537;4798.160321943646;4812.181929072049;4651.000034992459;4692.741899195543;4706.364640773486;4708.058388322349;4729.408823897013;4690.0854333405;4691.7184968901975;4712.104700107003;4717.481077081518;4742.834000809955;4946.777395017233;5006.549410553068;5019.121653710586;5021.472745361721;5063.518965698253;5436.646617969859;5503.367112782042;5529.972350138264;5549.833504994856;5588.4411558844195;5572.749226284827;5592.0773072443;5596.188552659842;5604.495595396393;5606.187102870102;5079.87300317495;5215.452377500345;5230.372355317386;5231.032259032053;5236.81671141512;5551.361593416728;5678.545716342683;5748.137779333133;5768.971155144198;5774.133879917962;5357.7589008494715;5367.087595108841;5369.570434365241;5373.435789242151;5387.138057910715;5440;5442.455754424605;5444.646098003696;5469.726513674301;5494.752736126804;5418.593605479605;5448.83653490396;5517.393086760453;5573.665580065209;5585.916211256835;5524.392316845144;5554.972225138848;5560.221568980346;5562.3047119110115;5562.721863906789;4235.110626768414;4318.201132790444;4322.373255877943;4338.980339620187;4377.606015458624;3803.676687481595;3841.078141246081;3867.303885300673;3878;3880.4373365861793;5077.441481437039;5078.593712503065;5079.314292570456;5082.237664350303;5087.364079490064;5440.6735595864375;5449.3460784706085;5453.127499600045;5498.780048798083;5525.336959564797;5032.220005899091;5064.974675126601;5077.086124497552;5125.897482050338;5137.2037334213255;4753.310769938409;4764.880877978009;4767.642426818003;4777.092352453023;4784.760761961888;5593.300837395325;5669.773209071591;5676.091825307931;5747.741351639186;5748.913766293509;5573.303337082864;5617.382087970238;5618.690971996416;5619.297587801525;5641.041023026178;5734.254546909042;5779.479846813807;5780.277465316835;5782.421757824184;5787.768489260382;5391.7034563099405;5460.208269800936;5467.835964921059;5483.479069488392;5508.531774799187;5568.77724891016;5593.216949627137;5599.524040456607;5625.549956003591;5643.435656434323;5424.566034717134;5459.645123067146;5463;5465.590080744039;5468.507834294933;5398.46015398457;5402.783888644567;5452.918206226989;5472.835814925558;5501.339839219159;5349.919751203813;5355.062863998707;5385.299911011543;5387.515123638891;5418.647787893932;5401.081816091352;5452.263944367618;5452.509274165185;5454.672719636835;5455.699936503531;5222.294990176278;5252.868678283074;5341.145416733304;5355.116405793001;5356.3572371315695 23:10:40 INFO - PROCESS | 28463 | |1;ext.html;541.0936681059225;546.6200990311735;549.793827314757;564.3989151553595;575.5913301555895;27975.86012069939;28609.856950715242;38025.049373765636;38644.61355386445;38645;42155.78922105393;42483.362749558706;42605.7869710651;42650.786746066224;42679.573204268025;8402.243798058158;8679.045305016474;8686.261667758248;8687.95656021719;8689.695860644848;8446.113158118402;8550.40147189697;8588.184122508352;8590.012148602897;8599.097094805018;8571.914280857205;8674.219320261176;8675.479471231747;8677.305815534774;8680.739577812676;8546.78633034176;8608.569571521399;8615.65537378504;8621.956890215572;8625.913740862605;8457.323414126855;8555.443896146731;8599.05410404855;8600.956995214983;8601.31189504838;38632.61367386347;39026.609733902864;39070.21859562821;39186.21627567433;39204.411933821015;3044.862981165853;3050.5271682888965;3136.2629782001213;3314.5193946877807;3411.4882767584813;29025.41949161026;29100.708992910222;29447.638961491633;29792.255193620116;30397.24006899823;3174.206448387903;3176.3170918252686;3178.3802158579088;3205.9198520036953;3294.5387645729616;196668;197304;197447;197490;197880;50959.490405096214;52580.73709631504;57204.71397642985;58113;58315.416845831845;58245.41754582485;58459.70770146122;58580.70709646425;58617.706911466026;58734.70632646809;12747.872521274854;13050.282234477005;14786.63033424173;14877.404903803943;14982.700345993018;11084.224104312621;11170.441477926233;11185.272957257752;11204.439778011067;11222.607208747655;18990.43028709141;19090.61818763617;19234.46124310052;19252.4224273272;19349.613007739765;7326.597037163007;7467.887981680279;7651.579163145969;7682.231776822385;7706.499077560053;717.1573401253506;742.7400409856507;747.9139898911586;781.4178437064423;869.556526171657;21101;21145.78854211469;21501.67747483789;21765.564688706138;22136.778632213794;841.3101256969348;871.3943809052774;877.4077497689034;938.7559234599054;941.1670671455811;12860.228386296665;13583.252921089237;14123.293835308194;14421.567352979428;14565.927170364292;318566;321714;321851;322496;322606;51630;51709.2243616346;51840.74079629653;51857.481425185266;51947.74026129921;1154.1920655541155;1185.7628474305172;1195.0559058343986;1251.0929576057285;1281.8846303832886;22027.559448810614;22652.320430387113;22727.77272227323;22832;22838.086476541415;35607.64392356147;37347.25305493929;37385;37403.81298093492;41726.37410438906;180799.09600451915;400678;405804;409915;409925;28975.5653665191;29758.25604359908;29817;29833.552496713;30024.249393764458;41161;41758.791206043774;41902;42554.78722606491;42691.57308427;34612.65458326187;34949;35041.474377883846;35257.471137932436;35610.82194589011;33630.3273934515;35310.75829689708;35850.28299434049;35975;36030.4595431074;28524.286892827844;29155;29170;29284;29359;27450;28387.290317741397;29354.706452935196;31504.842475787475;34076;20773.584528309046;21124.89437552864;21218.151273949486;21228.57542849165;21259.46851328729 23:10:40 INFO - PROCESS | 28463 | |2;jquery.html;366.251016670908;366.5601278465842;366.8972687647459;367.426814169895;375.89474947014844;13581.864181358183;13684.11053281536;15431.845681543182;16218.513444596652;16945.830541694595;15314.923425382885;15369.462068827594;16048.43830465934;16680.41618543351;16808.915955420205;5247.553957913582;5447.12845944649;5450.754716037768;5453.590980676446;5455.645383050089;3911.2373087247997;4114.321137012389;5289.259503669489;5414.91877621836;5649.435056494359;5708.422164219258;5764.394738552433;5824.737886795105;5824.883502329951;5825.359210486843;5699.458551437607;5895.233619629421;5926.97036514819;5928.170056192136;5930.970345148268;4919.385076865392;5084.593232541425;5085.644004919657;5236.266922630834;5240.528352448298;12735.235885846787;12897.935510322483;16228.918855405647;20125;20125.194992200293;1908.8377487913544;1930.9710354344695;1989.8706584071988;2035.4911272181955;2036.2262340310735;12772.744545109046;13081.86918130816;13251.13867598603;13557.525486607921;13703.177809331472;1811.9094045297813;1833.5782769962984;1877.7652793400825;1914.8755330903446;1923.2691577200715;62902.68548657227;63389;65419.018714719794;65557.67221163864;65669;14662.780058299135;14707.908583523766;14778.92610536962;14862.405503779944;15248.618784530476;13269.535566255136;13645.11306765077;23095.422614434436;23195.420114497272;23246.861673674175;7282.235365286675;7433.033705618235;7536.434767392468;7581.924180758122;7596.734114305973;7151.713931442684;7171.354578087997;7224.67488962998;7234.674439650228;7237.059182306267;4224.938972551291;4263.8081286342185;4514.413126293561;4532.5694059064335;4594.65540084495;1798.2627122879558;1824.1700026487915;1836.1610079945633;1849.7687789026372;1907.418237437567;679.4109793605342;768.3737753730692;768.5350363030398;806.3226889412921;834.7746108550657;14154.150750954976;14465.49370772039;14644.560663180122;14817.70364592702;14832.11007339563;774.6397924964806;789.4434423731255;794.8966634337614;802.5465611929242;809.2918696140877;8499.277561407225;8604.13958604147;8944.463332200088;9047.90952090484;9215.44707317563;339213;339640;468304;472627;475501;43929.34105988413;64691.70616587642;67134.66432667806;70978.64510677516;71648;1126.3523474002482;1129.836173754801;1138.607180522735;1140.7091191746051;1150.4075401168404;12750.68123296925;13185.60443186706;13605.863941360856;13762.24307663088;13892.305384730926;29536.409271814875;30011.399772004876;30235.732320076524;30657.846710766302;31342.52986205163;37917;38670;39157;39331.2133757329;39459.2108157841;3041.5893854330266;6576.145101137013;7147.785566433015;7194.604296763729;7436.553806771611;9502.809943801223;9935.503224838874;10368.637097701545;10506.264561480928;10662.147028237567;8276.599786061975;8489.533075680896;8504.872426913478;8782.648694052166;8807.339449541438;6291.748330066929;6785.864282714219;7079.964600176966;7100.147982242164;8625.95687021586;6683.198016238082;6717.899231511629;6797.218319893275;6878.58728476293;6900.206476255295;9859.654912078044;9863;9891.2581556385;10008.349457285252;10061.195104391485;9036.502992335485;9055.18503334703;9181.816363672555;9253.953730231575;9382.81234375295 23:10:40 INFO - PROCESS | 28463 | |3;mootools.html;1346.6229455752393;1436.2029073864;1442.1995792335254;1595.7127717010933;1792.399546152039;7013.3337332953415;7677.769666909995;7802.10275818281;7809.062912450499;7814.960925195381;7672.616369181533;7871.80320491988;7897.802554936129;7900.130985591581;7904.249096335839;2011.175418078588;2052.507398224423;2278.111536500766;2280.281711260952;2306.5732839424677;2304.4584522637165;2308.4921317310163;2313.2828823064906;2313.6529520571967;2314.618088015475;2248.87631180285;2310.0875154314035;2329.7320808107115;2331.5453486570127;2331.720193576773;2255.639097744361;2308.6421604651305;2311.4105902994797;2319.443333599924;2319.5708793873105;2240.025588868831;2251.0883092347626;2256.548690261954;2293.793558579736;2358.009635952904;7949.682012719484;7999.1600881907725;8008.359331253486;8011.839763204704;8034.236747508978;4581.885452863672;4649.04694537619;4664.207084795593;4668.766561671903;4673.462551806518;2998.14552852436;3005.4119121267363;3068.9079327620207;3137.450946084426;3176.7140957313954;940.0740270833223;944.7543638653931;978.6623614852864;981.2738573455663;994.8656931314252;10728.73178170544;10753.677389678322;10772.138228941743;10772.192085593533;10778.892211077868;4293.97853010733;4340.348947657877;4399.38408622793;4405.0969551241915;4413.713108647928;9309.534523273946;9320.394174378644;9321.254299656011;9322.813543729088;9325.694402783616;4819.95180048202;4830.154722923475;4858.489858564871;4865;4865.099956508057;4396.626286765597;4398.472183337956;4406.5593440655675;4406.625436837905;4409.162259170747;3438.793672379615;3496.877609283663;3610.891673249807;3621.5654121505063;3646.21606354635;1240.1319076646203;1240.2434514945876;1243.3907385381099;1250.7310928150491;1254.4229654358915;904.968326108583;919.1589695428607;919.2048877720723;943.8725772020689;1251.6620512461766;7026.191987921455;7048.92951070493;7050;7054.5061845671335;7054.576725396492;945.2107490245585;954.4845783276953;959.6536468334855;969.7575606098476;980.9362391444533;5603.271574695264;5668.688222147739;5689.175069614966;5689.68706721126;5691.743871525791;9190.08099190089;9352.485613291334;9481.857772133424;9489.572969216402;9497.43015419077;9307.953460232655;9318.72043838686;9324.160825525736;9354.95322523383;9355.298352623444;7222.783316500513;7402.1487528933785;7405.259763955466;7405.518641288407;7408.185099639036;7021.368076873106;7066.258042905626;7138.892916606152;7163.426925845815;7167.319104685047;8232.217939295757;8359.874601880854;8433.662653493791;8436.915630843612;8445.577721114043;8627.611757470804;8737.169968852948;8744.081871403665;8751.343649226461;8756.211940925092;6224.533160012927;6993.615351155735;7065.682044307916;7099.645017749195;7111.573305601681;6819.147606549182;7144.892826607501;7334.3032411920785;7350.338469537767;7372.963135184505;6875.312468753084;6992.825179370557;7049.859002820018;7072.858542829217;7155.248698886542;6796.66016699173;6833.214180369122;6842.486813489108;6915.066466027223;6948.0272761812375;6632.734690612515;6673.733050677918;6682.398584127452;6695.866082678416;6769.086173366532;6325.177726895658;6373.426391624776;6375.681215939092;6378.77674281398;6379.425851673372;6328.493720502257;6361.491080713439;6364.109024736633;6365.236171659245;6374.681265936777 23:10:40 INFO - PROCESS | 28463 | |4;prototype.html;326.75166873176386;332.396699989519;337.11171064245707;337.8834302165753;342.76349318969926;5709.543236541077;5869.295684517859;5879.412058794119;5890.587658863876;5892.88214235715;5696.515796157321;5829.708514574276;5844.357120716729;5863.618864773786;5870.559708021894;4577.885552861172;4578.290364993423;4578.336141259515;4578.748168850712;4578.862634120982;4377.409049778287;4452.866414007585;4479.776011199443;4482.394876691637;4572.291294849287;4433.889152771174;4462.955370446302;4501.887452813689;4507.188706032913;4513.435820522434;4488.618467430256;4489.451139356916;4492.0791237796175;4494.752788596626;4500.0774841157645;3950.8814735557694;3966.702497312684;3969.7419667721506;3971.3645816669195;3972.801359931992;5484.287042684466;5550.666959982414;5570.777168913279;5577.8047768327915;5581.274434323512;5209.0363282792805;5210.348706411699;5215.217717342391;5234.92147617786;5261.421243663232;5924.7333869975955;6227.532935029891;6242.531810114214;6245.531585131133;6256;4318.071614602875;4367.868963931087;4400.22995975703;4405.581469760367;4423.292273236267;6394.6482943438095;6455.289918109004;6490.545661803676;6500.414962653336;6509.739610415578;4477.574630410106;4502.864914052584;4503.211937910853;4506.3916371290115;4516.887077823015;4480.103979204172;4565.931511027337;4566.520515345907;4572.885677858014;4588.678792484561;5199.610029247821;5211.088059589557;5214.582833373397;5248.553872920845;5251.973740131351;6257.217847769029;6269.78055768055;6274.341194174637;6276.058591211355;6278.058291256348;1606.3173151410604;1622.594351412147;1625.2361390146611;1625.8211596724586;1631.5350125214256;1102.4212288548576;1107.2083460325905;1131.7057565032985;1133.8525991621202;1139.0545846947014;5945.048792193228;5955.612885162451;5957.165996760457;5960.046392577166;5960.254968128984;6416.871662566816;6422.903656445157;6424.550281480345;6432.807015789534;6439.9356006440275;5830.795922142789;5939.613925094855;5943.108533719977;5951.583389162717;5951.940480595225;3404.761666683358;3453.9481907771406;3462.4460086386057;3462.532558104674;3463.0476618929492;6631.56894801846;6642.900356494656;6697.631630260285;6701.698423570951;6705.396514313735;6560.179977502812;6565.835854103686;6568.343165683394;6569.605823650596;6577.375149360803;6522.445592124628;6668.633225172565;6672.099266599044;6689.866202675822;6690.498212634072;6223.813285601439;6369;6384.553081284265;6390.7443702251385;6396.42432181106;6286.9371306288185;6320.494360451245;6335.334789847;6349.111124442674;6349.936500634934;6709.664516774239;6728;6729.629870357177;6735.4274886635185;6739.292374300628;4504.414426124714;4596.965682721361;4604.953950460453;4611.6310695144975;4617.168909596305;6498.772542960974;6503.057056726842;6513.837154071186;6518.2178138621775;6521.413072823469;6276.874462510633;6305.243370795534;6324.525660575568;6338.778142764981;6346.111544383698;6126.448619624255;6288.088227207121;6300.779472718433;6300.8109756705535;6319.24169099711;6178.104174894525;6183.690815459299;6197.318294987457;6218.9378106218355;6292.748290068346;6375.936240637534;6439.774607888701;6440.806775796734;6442.710078046405;6444.065610486547;6020.337762845996;6188.164597779242;6199.411055949678;6202.34875338101;6209.161763161916 23:10:40 INFO - PROCESS | 28463 | |5;yui.html;770.7379490973068;802.4944285100382;804.8671969125091;808.959552022399;826.2316046077148;11871.169018168732;12060.035197184226;12075.094367922396;12081.697957551065;12084.033277337803;11215.327080375184;11289.266197697143;11293.265937714063;11297.548098076088;11303.886961130387;768.6041688530397;791.4934441957153;809.3323008517967;809.9959500202491;810.222186700768;498.9002199560084;508.8905885234674;803.5540275147321;806.3186607316837;806.818465845183;825.9463134896213;833.0461621443444;839.4627438439404;840.155643578203;840.3487297344545;803.863343231652;805.2832978648948;808.1756608259572;808.1918081918081;808.9150639182918;372.4115896882918;374.8463130116639;587.1544975235689;597.9133025711291;609.6281268426256;11800;11816.172867899251;11839;11849;11852.40737963107;11001.17491188164;11505.424728763528;11591.594294199662;11946.820797688042;12279.263244205376;9133.634654613808;9500.857487137699;9769.804603907953;9952.452615106165;10021.849672254923;3350.5644266245477;3354.3479237484917;3368.612609549884;3395.1681837949614;3482.3035392921265;46866.76566617145;46913.06173876538;47481;47826.760866195444;47915;8974.596143173572;9058.184763371197;9062.320325975577;9104;9173.128552787475;16675.749863752055;16803.663926721398;16876.83123168777;16922.661546768995;17006.659866802842;6526.28210896801;6621.3047629998155;6733.663316834139;6737.393634572912;7146.2496437874315;3544.3265779502326;3610.981945090258;3641.016925430119;3690.372636651776;3697.371446854041;2873.0231721214886;2876.0077773168223;2906.302487403008;2916.0668586052684;2921.985390073036;531.4897698209685;588.9293284805851;603.1706403694919;604.4559896093463;605.8061420345535;499.4880247746017;506.8428787076018;510.7650480778809;610.9205803245638;662.68522451835;7355.668994895243;7450.701971921062;7592.240775922363;7716.035495563055;7817.648205830751;501.6814322904909;502.47742347958444;526.1056204452447;544.7303584725507;664.6743095882982;3480.930381392358;3535.452004939187;3641.5448068991377;3642.1623026704005;3739.364308067635;57710.422895770505;62277;63082.68458657769;63237.36762632407;63253.36746632567;49811;49874.750626246634;50876;51834.74082629638;51997.2200416994;43650.34524482135;43829.56170438255;44891.32663010057;45970.77014614973;47336.52663473459;7557.168711441627;7743.380529557735;7838;7983.2415920487465;8045.9597702011115;29686.406271874872;30161.547576786805;30910;31266.843665781525;31826;38098.61901381062;38328.42507362336;40190.19619607533;41652.79173604112;41897.79051104725;10061.496925153566;10410.427426491313;10669.519871605951;10725.731856703645;10796.082333001783;11661.183717139718;11706.941465292619;11792.174547781573;11826.408679566159;12206.328651923874;9682.419054856731;9862.260330475387;9890.950545247228;10130.240231982778;10187.185025198114;10711.678649640524;10736.570537178426;10912.236143469881;11191.767431937069;11301.15241356885;10870.293430926964;10875.184361172785;11061.281016733887;11069.944650276697;11352.091832653203;8827.382083254368;8879.644814207359;8953.32850036263;9069.455832650063;9331.393459425115;8414.789630259293;9168.862467062865;9263.490508022123;9369.859452108087;9373.591261486528 23:10:40 INFO - PROCESS | 28463 | __end_tp_report 23:10:40 INFO - PROCESS | 28463 | __start_cc_report 23:10:40 INFO - PROCESS | 28463 | _x_x_mozilla_cycle_collect,826 23:10:40 INFO - PROCESS | 28463 | __end_cc_report 23:10:40 INFO - PROCESS | 28463 | __startTimestamp1453446640602__endTimestamp 23:10:40 INFO - PROCESS | 28463 | 23:10:40 INFO - PROCESS | 28463 | ------- Summary: start ------- 23:10:40 INFO - PROCESS | 28463 | Number of tests: 6 23:10:40 INFO - PROCESS | 28463 | 23:10:40 INFO - PROCESS | 28463 | [#0] dojo.html Cycles:165 Average:5141.46 Median:5357.76 stddev:561.27 (10.5%) stddev-sans-first:539.24 23:10:40 INFO - PROCESS | 28463 | Values: 3082.3 3127.3 3135.7 3173.1 3202.4 4921.9 5060.9 5088.1 5090.3 5127.8 5072.9 5177.9 5260.3 5262.3 5273.3 4661.5 4691.2 4700.6 4719.9 4753.8 4381.2 4739.1 4808.6 4811.0 4847.7 4648.6 4716.3 4762.3 4798.2 4812.2 4651.0 4692.7 4706.4 4708.1 4729.4 4690.1 4691.7 4712.1 4717.5 4742.8 4946.8 5006.5 5019.1 5021.5 5063.5 5436.6 5503.4 5530.0 5549.8 5588.4 5572.7 5592.1 5596.2 5604.5 5606.2 5079.9 5215.5 5230.4 5231.0 5236.8 5551.4 5678.5 5748.1 5769.0 5774.1 5357.8 5367.1 5369.6 5373.4 5387.1 5440.0 5442.5 5444.6 5469.7 5494.8 5418.6 5448.8 5517.4 5573.7 5585.9 5524.4 5555.0 5560.2 5562.3 5562.7 4235.1 4318.2 4322.4 4339.0 4377.6 3803.7 3841.1 3867.3 3878.0 3880.4 5077.4 5078.6 5079.3 5082.2 5087.4 5440.7 5449.3 5453.1 5498.8 5525.3 5032.2 5065.0 5077.1 5125.9 5137.2 4753.3 4764.9 4767.6 4777.1 4784.8 5593.3 5669.8 5676.1 5747.7 5748.9 5573.3 5617.4 5618.7 5619.3 5641.0 5734.3 5779.5 5780.3 5782.4 5787.8 5391.7 5460.2 5467.8 5483.5 5508.5 5568.8 5593.2 5599.5 5625.5 5643.4 5424.6 5459.6 5463.0 5465.6 5468.5 5398.5 5402.8 5452.9 5472.8 5501.3 5349.9 5355.1 5385.3 5387.5 5418.6 5401.1 5452.3 5452.5 5454.7 5455.7 5222.3 5252.9 5341.1 5355.1 5356.4 23:10:40 INFO - PROCESS | 28463 | 23:10:40 INFO - PROCESS | 28463 | [#1] ext.html Cycles:180 Average:44855.13 Median:35730.55 stddev:80905.46 (226.4%) stddev-sans-first:81064.01 23:10:40 INFO - PROCESS | 28463 | Values: 541.1 546.6 549.8 564.4 575.6 27975.9 28609.9 38025.0 38644.6 38645.0 42155.8 42483.4 42605.8 42650.8 42679.6 8402.2 8679.0 8686.3 8688.0 8689.7 8446.1 8550.4 8588.2 8590.0 8599.1 8571.9 8674.2 8675.5 8677.3 8680.7 8546.8 8608.6 8615.7 8622.0 8625.9 8457.3 8555.4 8599.1 8601.0 8601.3 38632.6 39026.6 39070.2 39186.2 39204.4 3044.9 3050.5 3136.3 3314.5 3411.5 29025.4 29100.7 29447.6 29792.3 30397.2 3174.2 3176.3 3178.4 3205.9 3294.5 196668.0 197304.0 197447.0 197490.0 197880.0 50959.5 52580.7 57204.7 58113.0 58315.4 58245.4 58459.7 58580.7 58617.7 58734.7 12747.9 13050.3 14786.6 14877.4 14982.7 11084.2 11170.4 11185.3 11204.4 11222.6 18990.4 19090.6 19234.5 19252.4 19349.6 7326.6 7467.9 7651.6 7682.2 7706.5 717.2 742.7 747.9 781.4 869.6 21101.0 21145.8 21501.7 21765.6 22136.8 841.3 871.4 877.4 938.8 941.2 12860.2 13583.3 14123.3 14421.6 14565.9 318566.0 321714.0 321851.0 322496.0 322606.0 51630.0 51709.2 51840.7 51857.5 51947.7 1154.2 1185.8 1195.1 1251.1 1281.9 22027.6 22652.3 22727.8 22832.0 22838.1 35607.6 37347.3 37385.0 37403.8 41726.4 180799.1 400678.0 405804.0 409915.0 409925.0 28975.6 29758.3 29817.0 29833.6 30024.2 41161.0 41758.8 41902.0 42554.8 42691.6 34612.7 34949.0 35041.5 35257.5 35610.8 33630.3 35310.8 35850.3 35975.0 36030.5 28524.3 29155.0 29170.0 29284.0 29359.0 27450.0 28387.3 29354.7 31504.8 34076.0 20773.6 21124.9 21218.2 21228.6 21259.5 23:10:40 INFO - PROCESS | 28463 | 23:10:40 INFO - PROCESS | 28463 | [#2] jquery.html Cycles:180 Average:23933.63 Median:236449.33 stddev:69477.61 (29.4%) stddev-sans-first:69649.98 23:10:40 INFO - PROCESS | 28463 | Values: 366.3 366.6 366.9 367.4 375.9 13581.9 13684.1 15431.8 16218.5 16945.8 15314.9 15369.5 16048.4 16680.4 16808.9 5247.6 5447.1 5450.8 5453.6 5455.6 3911.2 4114.3 5289.3 5414.9 5649.4 5708.4 5764.4 5824.7 5824.9 5825.4 5699.5 5895.2 5927.0 5928.2 5931.0 4919.4 5084.6 5085.6 5236.3 5240.5 12735.2 12897.9 16228.9 20125.0 20125.2 1908.8 1931.0 1989.9 2035.5 2036.2 12772.7 13081.9 13251.1 13557.5 13703.2 1811.9 1833.6 1877.8 1914.9 1923.3 62902.7 63389.0 65419.0 65557.7 65669.0 14662.8 14707.9 14778.9 14862.4 15248.6 13269.5 13645.1 23095.4 23195.4 23246.9 7282.2 7433.0 7536.4 7581.9 7596.7 7151.7 7171.4 7224.7 7234.7 7237.1 4224.9 4263.8 4514.4 4532.6 4594.7 1798.3 1824.2 1836.2 1849.8 1907.4 679.4 768.4 768.5 806.3 834.8 14154.2 14465.5 14644.6 14817.7 14832.1 774.6 789.4 794.9 802.5 809.3 8499.3 8604.1 8944.5 9047.9 9215.4 339213.0 339640.0 468304.0 472627.0 475501.0 43929.3 64691.7 67134.7 70978.6 71648.0 1126.4 1129.8 1138.6 1140.7 1150.4 12750.7 13185.6 13605.9 13762.2 13892.3 29536.4 30011.4 30235.7 30657.8 31342.5 37917.0 38670.0 39157.0 39331.2 39459.2 3041.6 6576.1 7147.8 7194.6 7436.6 9502.8 9935.5 10368.6 10506.3 10662.1 8276.6 8489.5 8504.9 8782.6 8807.3 6291.7 6785.9 7080.0 7100.1 8626.0 6683.2 6717.9 6797.2 6878.6 6900.2 9859.7 9863.0 9891.3 10008.3 10061.2 9036.5 9055.2 9181.8 9254.0 9382.8 23:10:40 INFO - PROCESS | 28463 | 23:10:40 INFO - PROCESS | 28463 | [#3] mootools.html Cycles:180 Average:5444.18 Median:6732.48 stddev:2838.80 (42.2%) stddev-sans-first:2830.06 23:10:40 INFO - PROCESS | 28463 | Values: 1346.6 1436.2 1442.2 1595.7 1792.4 7013.3 7677.8 7802.1 7809.1 7815.0 7672.6 7871.8 7897.8 7900.1 7904.2 2011.2 2052.5 2278.1 2280.3 2306.6 2304.5 2308.5 2313.3 2313.7 2314.6 2248.9 2310.1 2329.7 2331.5 2331.7 2255.6 2308.6 2311.4 2319.4 2319.6 2240.0 2251.1 2256.5 2293.8 2358.0 7949.7 7999.2 8008.4 8011.8 8034.2 4581.9 4649.0 4664.2 4668.8 4673.5 2998.1 3005.4 3068.9 3137.5 3176.7 940.1 944.8 978.7 981.3 994.9 10728.7 10753.7 10772.1 10772.2 10778.9 4294.0 4340.3 4399.4 4405.1 4413.7 9309.5 9320.4 9321.3 9322.8 9325.7 4820.0 4830.2 4858.5 4865.0 4865.1 4396.6 4398.5 4406.6 4406.6 4409.2 3438.8 3496.9 3610.9 3621.6 3646.2 1240.1 1240.2 1243.4 1250.7 1254.4 905.0 919.2 919.2 943.9 1251.7 7026.2 7048.9 7050.0 7054.5 7054.6 945.2 954.5 959.7 969.8 980.9 5603.3 5668.7 5689.2 5689.7 5691.7 9190.1 9352.5 9481.9 9489.6 9497.4 9308.0 9318.7 9324.2 9355.0 9355.3 7222.8 7402.1 7405.3 7405.5 7408.2 7021.4 7066.3 7138.9 7163.4 7167.3 8232.2 8359.9 8433.7 8436.9 8445.6 8627.6 8737.2 8744.1 8751.3 8756.2 6224.5 6993.6 7065.7 7099.6 7111.6 6819.1 7144.9 7334.3 7350.3 7373.0 6875.3 6992.8 7049.9 7072.9 7155.2 6796.7 6833.2 6842.5 6915.1 6948.0 6632.7 6673.7 6682.4 6695.9 6769.1 6325.2 6373.4 6375.7 6378.8 6379.4 6328.5 6361.5 6364.1 6365.2 6374.7 23:10:40 INFO - PROCESS | 28463 | 23:10:40 INFO - PROCESS | 28463 | [#4] prototype.html Cycles:180 Average:5240.47 Median:5908.81 stddev:1563.11 (26.5%) stddev-sans-first:1523.37 23:10:40 INFO - PROCESS | 28463 | Values: 326.8 332.4 337.1 337.9 342.8 5709.5 5869.3 5879.4 5890.6 5892.9 5696.5 5829.7 5844.4 5863.6 5870.6 4577.9 4578.3 4578.3 4578.7 4578.9 4377.4 4452.9 4479.8 4482.4 4572.3 4433.9 4463.0 4501.9 4507.2 4513.4 4488.6 4489.5 4492.1 4494.8 4500.1 3950.9 3966.7 3969.7 3971.4 3972.8 5484.3 5550.7 5570.8 5577.8 5581.3 5209.0 5210.3 5215.2 5234.9 5261.4 5924.7 6227.5 6242.5 6245.5 6256.0 4318.1 4367.9 4400.2 4405.6 4423.3 6394.6 6455.3 6490.5 6500.4 6509.7 4477.6 4502.9 4503.2 4506.4 4516.9 4480.1 4565.9 4566.5 4572.9 4588.7 5199.6 5211.1 5214.6 5248.6 5252.0 6257.2 6269.8 6274.3 6276.1 6278.1 1606.3 1622.6 1625.2 1625.8 1631.5 1102.4 1107.2 1131.7 1133.9 1139.1 5945.0 5955.6 5957.2 5960.0 5960.3 6416.9 6422.9 6424.6 6432.8 6439.9 5830.8 5939.6 5943.1 5951.6 5951.9 3404.8 3453.9 3462.4 3462.5 3463.0 6631.6 6642.9 6697.6 6701.7 6705.4 6560.2 6565.8 6568.3 6569.6 6577.4 6522.4 6668.6 6672.1 6689.9 6690.5 6223.8 6369.0 6384.6 6390.7 6396.4 6286.9 6320.5 6335.3 6349.1 6349.9 6709.7 6728.0 6729.6 6735.4 6739.3 4504.4 4597.0 4605.0 4611.6 4617.2 6498.8 6503.1 6513.8 6518.2 6521.4 6276.9 6305.2 6324.5 6338.8 6346.1 6126.4 6288.1 6300.8 6300.8 6319.2 6178.1 6183.7 6197.3 6218.9 6292.7 6375.9 6439.8 6440.8 6442.7 6444.1 6020.3 6188.2 6199.4 6202.3 6209.2 23:10:40 INFO - PROCESS | 28463 | 23:10:40 INFO - PROCESS | 28463 | [#5] yui.html Cycles:180 Average:13134.81 Median:25154.95 stddev:15887.18 (63.2%) stddev-sans-first:15904.62 23:10:40 INFO - PROCESS | 28463 | Values: 770.7 802.5 804.9 809.0 826.2 11871.2 12060.0 12075.1 12081.7 12084.0 11215.3 11289.3 11293.3 11297.5 11303.9 768.6 791.5 809.3 810.0 810.2 498.9 508.9 803.6 806.3 806.8 825.9 833.0 839.5 840.2 840.3 803.9 805.3 808.2 808.2 808.9 372.4 374.8 587.2 597.9 609.6 11800.0 11816.2 11839.0 11849.0 11852.4 11001.2 11505.4 11591.6 11946.8 12279.3 9133.6 9500.9 9769.8 9952.5 10021.8 3350.6 3354.3 3368.6 3395.2 3482.3 46866.8 46913.1 47481.0 47826.8 47915.0 8974.6 9058.2 9062.3 9104.0 9173.1 16675.7 16803.7 16876.8 16922.7 17006.7 6526.3 6621.3 6733.7 6737.4 7146.2 3544.3 3611.0 3641.0 3690.4 3697.4 2873.0 2876.0 2906.3 2916.1 2922.0 531.5 588.9 603.2 604.5 605.8 499.5 506.8 510.8 610.9 662.7 7355.7 7450.7 7592.2 7716.0 7817.6 501.7 502.5 526.1 544.7 664.7 3480.9 3535.5 3641.5 3642.2 3739.4 57710.4 62277.0 63082.7 63237.4 63253.4 49811.0 49874.8 50876.0 51834.7 51997.2 43650.3 43829.6 44891.3 45970.8 47336.5 7557.2 7743.4 7838.0 7983.2 8046.0 29686.4 30161.5 30910.0 31266.8 31826.0 38098.6 38328.4 40190.2 41652.8 41897.8 10061.5 10410.4 10669.5 10725.7 10796.1 11661.2 11706.9 11792.2 11826.4 12206.3 9682.4 9862.3 9891.0 10130.2 10187.2 10711.7 10736.6 10912.2 11191.8 11301.2 10870.3 10875.2 11061.3 11069.9 11352.1 8827.4 8879.6 8953.3 9069.5 9331.4 8414.8 9168.9 9263.5 9369.9 9373.6 23:10:40 INFO - PROCESS | 28463 | -------- Summary: end -------- 23:10:40 INFO - PROCESS | 28463 | 23:10:41 INFO - TEST-INFO | 28463: exit 0 23:10:41 INFO - TEST-OK | dromaeo_css | took 1112822ms 23:10:41 INFO - TEST-START | kraken 23:10:41 INFO - operating with platform_type : linux_ 23:10:41 INFO - Initialising browser for kraken test... 23:10:41 INFO - TEST-INFO | started process 28656 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXWvVc9/profile http://localhost:36518/getInfo.html) 23:10:45 INFO - PROCESS | 28656 | __metrics Screen width/height:1600/1200 23:10:45 INFO - PROCESS | 28656 | colorDepth:24 23:10:45 INFO - PROCESS | 28656 | Browser inner width/height: 1024/697 23:10:45 INFO - PROCESS | 28656 | __metrics 23:10:45 INFO - PROCESS | 28656 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:10:45 INFO - PROCESS | 28656 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:10:46 INFO - TEST-INFO | 28656: exit 0 23:10:46 INFO - Browser initialized. 23:10:46 INFO - Running cycle 1/1 for kraken test... 23:10:46 INFO - TEST-INFO | started process 28737 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpXWvVc9/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:10:58 INFO - PROCESS | 28737 | RSS: Main: 149540864 23:10:58 INFO - PROCESS | 28737 | 23:11:00 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36518/tests/kraken/driver.html?testName=audio-beat-detection) 23:11:01 INFO - PROCESS | 28737 | RSS: Main: 189186048 23:11:01 INFO - PROCESS | 28737 | 23:11:04 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36518/tests/kraken/driver.html?testName=audio-dft) 23:11:04 INFO - PROCESS | 28737 | RSS: Main: 178429952 23:11:04 INFO - PROCESS | 28737 | 23:11:07 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36518/tests/kraken/driver.html?testName=audio-fft) 23:11:08 INFO - PROCESS | 28737 | RSS: Main: 164458496 23:11:08 INFO - PROCESS | 28737 | 23:11:10 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36518/tests/kraken/driver.html?testName=audio-oscillator) 23:11:10 INFO - PROCESS | 28737 | RSS: Main: 167854080 23:11:10 INFO - PROCESS | 28737 | 23:11:12 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36518/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:11:13 INFO - PROCESS | 28737 | RSS: Main: 167485440 23:11:13 INFO - PROCESS | 28737 | 23:11:16 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36518/tests/kraken/driver.html?testName=imaging-darkroom) 23:11:16 INFO - PROCESS | 28737 | RSS: Main: 168558592 23:11:16 INFO - PROCESS | 28737 | 23:11:20 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36518/tests/kraken/driver.html?testName=imaging-desaturate) 23:11:20 INFO - PROCESS | 28737 | RSS: Main: 170692608 23:11:20 INFO - PROCESS | 28737 | 23:11:23 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36518/tests/kraken/driver.html?testName=json-parse-financial) 23:11:24 INFO - PROCESS | 28737 | RSS: Main: 168755200 23:11:24 INFO - PROCESS | 28737 | 23:11:25 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36518/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:11:26 INFO - PROCESS | 28737 | RSS: Main: 183705600 23:11:26 INFO - PROCESS | 28737 | 23:11:28 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:11:28 INFO - PROCESS | 28737 | RSS: Main: 181039104 23:11:28 INFO - PROCESS | 28737 | 23:11:30 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:11:31 INFO - PROCESS | 28737 | RSS: Main: 190205952 23:11:31 INFO - PROCESS | 28737 | 23:11:33 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:11:34 INFO - PROCESS | 28737 | RSS: Main: 197582848 23:11:34 INFO - PROCESS | 28737 | 23:11:36 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:11:37 INFO - PROCESS | 28737 | RSS: Main: 194822144 23:11:37 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | Cycle 1(1): loaded http://localhost:36518/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36518/tests/kraken/driver.html?testName=ai-astar) 23:11:39 INFO - PROCESS | 28737 | RSS: Main: 251752448 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | __start_tp_report 23:11:39 INFO - PROCESS | 28737 | _x_x_mozilla_page_load 23:11:39 INFO - PROCESS | 28737 | _x_x_mozilla_page_load_details 23:11:39 INFO - PROCESS | 28737 | |i|pagename|runs| 23:11:39 INFO - PROCESS | 28737 | |0;ai-astar;110;112;108;110;109;111;112;112;105;112 23:11:39 INFO - PROCESS | 28737 | |1;audio-beat-detection;151;129;152;173;131;152;149;129;168;134 23:11:39 INFO - PROCESS | 28737 | |2;audio-dft;162;161;160;160;160;161;159;159;160;161 23:11:39 INFO - PROCESS | 28737 | |3;audio-fft;73;74;93;93;74;73;73;133;94;73 23:11:39 INFO - PROCESS | 28737 | |4;audio-oscillator;95;96;149;95;94;95;142;95;96;141 23:11:39 INFO - PROCESS | 28737 | |5;imaging-gaussian-blur;109;109;110;110;109;110;109;110;109;110 23:11:39 INFO - PROCESS | 28737 | |6;imaging-darkroom;146;146;146;146;146;147;146;147;146;147 23:11:39 INFO - PROCESS | 28737 | |7;imaging-desaturate;95;96;96;95;96;96;96;96;95;95 23:11:39 INFO - PROCESS | 28737 | |8;json-parse-financial;56;56;57;55;55;56;57;57;56;54 23:11:39 INFO - PROCESS | 28737 | |9;json-stringify-tinderbox;69;69;69;69;71;70;69;69;69;70 23:11:39 INFO - PROCESS | 28737 | |10;stanford-crypto-aes;83;82;83;83;83;83;85;83;87;82 23:11:39 INFO - PROCESS | 28737 | |11;stanford-crypto-ccm;114;117;121;116;121;113;124;115;115;122 23:11:39 INFO - PROCESS | 28737 | |12;stanford-crypto-pbkdf2;154;140;142;141;155;136;147;141;142;151 23:11:39 INFO - PROCESS | 28737 | |13;stanford-crypto-sha256-iterative;68;67;77;65;66;66;67;65;68;67 23:11:39 INFO - PROCESS | 28737 | __end_tp_report 23:11:39 INFO - PROCESS | 28737 | __start_cc_report 23:11:39 INFO - PROCESS | 28737 | _x_x_mozilla_cycle_collect,959 23:11:39 INFO - PROCESS | 28737 | __end_cc_report 23:11:39 INFO - PROCESS | 28737 | __startTimestamp1453446699351__endTimestamp 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | ------- Summary: start ------- 23:11:39 INFO - PROCESS | 28737 | Number of tests: 14 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.50 stddev:2.28 (2.0%) stddev-sans-first:2.42 23:11:39 INFO - PROCESS | 28737 | Values: 110.0 112.0 108.0 110.0 109.0 111.0 112.0 112.0 105.0 112.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#1] audio-beat-detection Cycles:10 Average:146.80 Median:151.50 stddev:15.85 (10.5%) stddev-sans-first:16.73 23:11:39 INFO - PROCESS | 28737 | Values: 151.0 129.0 152.0 173.0 131.0 152.0 149.0 129.0 168.0 134.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#2] audio-dft Cycles:10 Average:160.30 Median:160.50 stddev:0.95 (0.6%) stddev-sans-first:0.78 23:11:39 INFO - PROCESS | 28737 | Values: 162.0 161.0 160.0 160.0 160.0 161.0 159.0 159.0 160.0 161.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#3] audio-fft Cycles:10 Average:85.30 Median:74.00 stddev:19.24 (26.0%) stddev-sans-first:19.88 23:11:39 INFO - PROCESS | 28737 | Values: 73.0 74.0 93.0 93.0 74.0 73.0 73.0 133.0 94.0 73.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#4] audio-oscillator Cycles:10 Average:109.80 Median:95.00 stddev:23.70 (24.9%) stddev-sans-first:24.52 23:11:39 INFO - PROCESS | 28737 | Values: 95.0 96.0 149.0 95.0 94.0 95.0 142.0 95.0 96.0 141.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:11:39 INFO - PROCESS | 28737 | Values: 109.0 109.0 110.0 110.0 109.0 110.0 109.0 110.0 109.0 110.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 23:11:39 INFO - PROCESS | 28737 | Values: 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 23:11:39 INFO - PROCESS | 28737 | Values: 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:56.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 23:11:39 INFO - PROCESS | 28737 | Values: 56.0 56.0 57.0 55.0 55.0 56.0 57.0 57.0 56.0 54.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 23:11:39 INFO - PROCESS | 28737 | Values: 69.0 69.0 69.0 69.0 71.0 70.0 69.0 69.0 69.0 70.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:1.51 (1.8%) stddev-sans-first:1.59 23:11:39 INFO - PROCESS | 28737 | Values: 83.0 82.0 83.0 83.0 83.0 83.0 85.0 83.0 87.0 82.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#11] stanford-crypto-ccm Cycles:10 Average:117.80 Median:119.00 stddev:3.85 (3.2%) stddev-sans-first:3.83 23:11:39 INFO - PROCESS | 28737 | Values: 114.0 117.0 121.0 116.0 121.0 113.0 124.0 115.0 115.0 122.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:144.50 stddev:6.47 (4.5%) stddev-sans-first:5.97 23:11:39 INFO - PROCESS | 28737 | Values: 154.0 140.0 142.0 141.0 155.0 136.0 147.0 141.0 142.0 151.0 23:11:39 INFO - PROCESS | 28737 | 23:11:39 INFO - PROCESS | 28737 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:67.00 stddev:3.47 (5.2%) stddev-sans-first:3.68 23:11:39 INFO - PROCESS | 28737 | Values: 68.0 67.0 77.0 65.0 66.0 66.0 67.0 65.0 68.0 67.0 23:11:39 INFO - PROCESS | 28737 | -------- Summary: end -------- 23:11:39 INFO - PROCESS | 28737 | 23:11:40 INFO - TEST-INFO | 28737: exit 0 23:11:40 INFO - TEST-OK | kraken | took 59014ms 23:11:40 INFO - TEST-START | v8_7 23:11:40 INFO - operating with platform_type : linux_ 23:11:40 INFO - Initialising browser for v8_7 test... 23:11:40 INFO - TEST-INFO | started process 28984 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQPs0Jn/profile http://localhost:36518/getInfo.html) 23:11:44 INFO - PROCESS | 28984 | __metrics Screen width/height:1600/1200 23:11:44 INFO - PROCESS | 28984 | colorDepth:24 23:11:44 INFO - PROCESS | 28984 | Browser inner width/height: 1024/697 23:11:44 INFO - PROCESS | 28984 | __metrics 23:11:44 INFO - PROCESS | 28984 | JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 23:11:44 INFO - PROCESS | 28984 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:11:45 INFO - TEST-INFO | 28984: exit 0 23:11:45 INFO - Browser initialized. 23:11:45 INFO - Running cycle 1/1 for v8_7 test... 23:11:45 INFO - TEST-INFO | started process 29066 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpQPs0Jn/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:57 INFO - PROCESS | 29066 | RSS: Main: 149733376 23:11:57 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | Cycle 1(1): loaded http://localhost:36518/tests/v8_7/run.html (next: http://localhost:36518/tests/v8_7/run.html) 23:12:19 INFO - PROCESS | 29066 | RSS: Main: 476291072 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | __start_tp_report 23:12:19 INFO - PROCESS | 29066 | _x_x_mozilla_page_load 23:12:19 INFO - PROCESS | 29066 | _x_x_mozilla_page_load_details 23:12:19 INFO - PROCESS | 29066 | |i|pagename|runs| 23:12:19 INFO - PROCESS | 29066 | |0;Richards;167.6727028839705 23:12:19 INFO - PROCESS | 29066 | |1;DeltaBlue;191.75455417066155 23:12:19 INFO - PROCESS | 29066 | |2;Encrypt;281.29395218002816 23:12:19 INFO - PROCESS | 29066 | |3;Decrypt;5186.5284974093265 23:12:19 INFO - PROCESS | 29066 | |4;RayTrace;1131.2217194570135 23:12:19 INFO - PROCESS | 29066 | |5;Earley;796.1783439490446 23:12:19 INFO - PROCESS | 29066 | |6;Boyer;12419.753086419752 23:12:19 INFO - PROCESS | 29066 | |7;RegExp;42062.5 23:12:19 INFO - PROCESS | 29066 | |8;Splay;577.0340450086555 23:12:19 INFO - PROCESS | 29066 | |9;NavierStokes;4817.307692307692 23:12:19 INFO - PROCESS | 29066 | __end_tp_report 23:12:19 INFO - PROCESS | 29066 | __startTimestamp1453446739762__endTimestamp 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | ------- Summary: start ------- 23:12:19 INFO - PROCESS | 29066 | Number of tests: 10 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#0] Richards Cycles:1 Average:167.67 Median:167.67 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 167.7 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#1] DeltaBlue Cycles:1 Average:191.75 Median:191.75 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 191.8 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#2] Encrypt Cycles:1 Average:281.29 Median:281.29 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 281.3 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 5186.5 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#4] RayTrace Cycles:1 Average:1131.22 Median:1131.22 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 1131.2 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#5] Earley Cycles:1 Average:796.18 Median:796.18 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 796.2 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#6] Boyer Cycles:1 Average:12419.75 Median:12419.75 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 12419.8 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#7] RegExp Cycles:1 Average:42062.50 Median:42062.50 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 42062.5 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#8] Splay Cycles:1 Average:577.03 Median:577.03 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 577.0 23:12:19 INFO - PROCESS | 29066 | 23:12:19 INFO - PROCESS | 29066 | [#9] NavierStokes Cycles:1 Average:4817.31 Median:4817.31 stddev:0.00 (0.0%) 23:12:19 INFO - PROCESS | 29066 | Values: 4817.3 23:12:19 INFO - PROCESS | 29066 | -------- Summary: end -------- 23:12:19 INFO - PROCESS | 29066 | 23:12:20 INFO - TEST-INFO | 29066: exit 0 23:12:20 INFO - TEST-OK | v8_7 | took 40342ms 23:12:20 INFO - SUITE-END | took 1212s 23:12:20 INFO - Completed test suite (00:20:12) 23:12:20 INFO - Working with test: dromaeo_css 23:12:20 INFO - Generating results file: dromaeo_css 23:12:20 INFO - Working with test: kraken 23:12:20 INFO - Generating results file: kraken 23:12:20 INFO - javascript benchmark 23:12:20 INFO - Working with test: v8_7 23:12:20 INFO - Generating results file: v8_7 23:12:20 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:12:20 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,201,35]] 23:12:20 INFO - process_Request line: dromaeo_css 6636.74 graph.html#tests=[[72,201,35]] 23:12:20 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:12:20 INFO - process_Request line: kraken 1502.70 graph.html#tests=[[232,201,35]] 23:12:20 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 23:12:20 INFO - process_Request line: v8_7 20013.70 graph.html#tests=[[230,201,35]] 23:12:20 INFO - RETURN: dromaeo_css: 6636.74 23:12:20 INFO - RETURN: kraken: 1502.70 23:12:20 INFO - RETURN: v8_7: 20013.70 23:12:20 INFO - javascript benchmark 23:12:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3082.306481041765, 3127.280725433152, 3135.655077941426, 3173.111528771943, 3202.4075546023987, 4921.926171107436, 5060.949390506094, 5088.109580823355, 5090.261912022755, 5127.820526281581, 5072.898542029157, 5177.896442071156, 5260.263563101169, 5262.263283140353, 5273.34083239595, 4661.510541393156, 4691.179043667345, 4700.623950083985, 4719.882002949919, 4753.786079626408, 4381.189479946204, 4739.099571081483, 4808.591269742059, 4810.951890481103, 4847.684900481475, 4648.558386953234, 4716.316134160562, 4762.309465127537, 4798.160321943646, 4812.181929072049, 4651.000034992459, 4692.741899195543, 4706.364640773486, 4708.058388322349, 4729.408823897013, 4690.0854333405, 4691.7184968901975, 4712.104700107003, 4717.481077081518, 4742.834000809955, 4946.777395017233, 5006.549410553068, 5019.121653710586, 5021.472745361721, 5063.518965698253, 5436.646617969859, 5503.367112782042, 5529.972350138264, 5549.833504994856, 5588.4411558844195, 5572.749226284827, 5592.0773072443, 5596.188552659842, 5604.495595396393, 5606.187102870102, 5079.87300317495, 5215.452377500345, 5230.372355317386, 5231.032259032053, 5236.81671141512, 5551.361593416728, 5678.545716342683, 5748.137779333133, 5768.971155144198, 5774.133879917962, 5357.7589008494715, 5367.087595108841, 5369.570434365241, 5373.435789242151, 5387.138057910715, 5440.0, 5442.455754424605, 5444.646098003696, 5469.726513674301, 5494.752736126804, 5418.593605479605, 5448.83653490396, 5517.393086760453, 5573.665580065209, 5585.916211256835, 5524.392316845144, 5554.972225138848, 5560.221568980346, 5562.3047119110115, 5562.721863906789, 4235.110626768414, 4318.201132790444, 4322.373255877943, 4338.980339620187, 4377.606015458624, 3803.676687481595, 3841.078141246081, 3867.303885300673, 3878.0, 3880.4373365861793, 5077.441481437039, 5078.593712503065, 5079.314292570456, 5082.237664350303, 5087.364079490064, 5440.6735595864375, 5449.3460784706085, 5453.127499600045, 5498.780048798083, 5525.336959564797, 5032.220005899091, 5064.974675126601, 5077.086124497552, 5125.897482050338, 5137.2037334213255, 4753.310769938409, 4764.880877978009, 4767.642426818003, 4777.092352453023, 4784.760761961888, 5593.300837395325, 5669.773209071591, 5676.091825307931, 5747.741351639186, 5748.913766293509, 5573.303337082864, 5617.382087970238, 5618.690971996416, 5619.297587801525, 5641.041023026178, 5734.254546909042, 5779.479846813807, 5780.277465316835, 5782.421757824184, 5787.768489260382, 5391.7034563099405, 5460.208269800936, 5467.835964921059, 5483.479069488392, 5508.531774799187, 5568.77724891016, 5593.216949627137, 5599.524040456607, 5625.549956003591, 5643.435656434323, 5424.566034717134, 5459.645123067146, 5463.0, 5465.590080744039, 5468.507834294933, 5398.46015398457, 5402.783888644567, 5452.918206226989, 5472.835814925558, 5501.339839219159, 5349.919751203813, 5355.062863998707, 5385.299911011543, 5387.515123638891, 5418.647787893932, 5401.081816091352, 5452.263944367618, 5452.509274165185, 5454.672719636835, 5455.699936503531, 5222.294990176278, 5252.868678283074, 5341.145416733304, 5355.116405793001, 5356.3572371315695], "unit": "score", "name": "dojo.html", "value": 5106.076684988296}, {"lowerIsBetter": false, "replicates": [541.0936681059225, 546.6200990311735, 549.793827314757, 564.3989151553595, 575.5913301555895, 27975.86012069939, 28609.856950715242, 38025.049373765636, 38644.61355386445, 38645.0, 42155.78922105393, 42483.362749558706, 42605.7869710651, 42650.786746066224, 42679.573204268025, 8402.243798058158, 8679.045305016474, 8686.261667758248, 8687.95656021719, 8689.695860644848, 8446.113158118402, 8550.40147189697, 8588.184122508352, 8590.012148602897, 8599.097094805018, 8571.914280857205, 8674.219320261176, 8675.479471231747, 8677.305815534774, 8680.739577812676, 8546.78633034176, 8608.569571521399, 8615.65537378504, 8621.956890215572, 8625.913740862605, 8457.323414126855, 8555.443896146731, 8599.05410404855, 8600.956995214983, 8601.31189504838, 38632.61367386347, 39026.609733902864, 39070.21859562821, 39186.21627567433, 39204.411933821015, 3044.862981165853, 3050.5271682888965, 3136.2629782001213, 3314.5193946877807, 3411.4882767584813, 29025.41949161026, 29100.708992910222, 29447.638961491633, 29792.255193620116, 30397.24006899823, 3174.206448387903, 3176.3170918252686, 3178.3802158579088, 3205.9198520036953, 3294.5387645729616, 196668.0, 197304.0, 197447.0, 197490.0, 197880.0, 50959.490405096214, 52580.73709631504, 57204.71397642985, 58113.0, 58315.416845831845, 58245.41754582485, 58459.70770146122, 58580.70709646425, 58617.706911466026, 58734.70632646809, 12747.872521274854, 13050.282234477005, 14786.63033424173, 14877.404903803943, 14982.700345993018, 11084.224104312621, 11170.441477926233, 11185.272957257752, 11204.439778011067, 11222.607208747655, 18990.43028709141, 19090.61818763617, 19234.46124310052, 19252.4224273272, 19349.613007739765, 7326.597037163007, 7467.887981680279, 7651.579163145969, 7682.231776822385, 7706.499077560053, 717.1573401253506, 742.7400409856507, 747.9139898911586, 781.4178437064423, 869.556526171657, 21101.0, 21145.78854211469, 21501.67747483789, 21765.564688706138, 22136.778632213794, 841.3101256969348, 871.3943809052774, 877.4077497689034, 938.7559234599054, 941.1670671455811, 12860.228386296665, 13583.252921089237, 14123.293835308194, 14421.567352979428, 14565.927170364292, 318566.0, 321714.0, 321851.0, 322496.0, 322606.0, 51630.0, 51709.2243616346, 51840.74079629653, 51857.481425185266, 51947.74026129921, 1154.1920655541155, 1185.7628474305172, 1195.0559058343986, 1251.0929576057285, 1281.8846303832886, 22027.559448810614, 22652.320430387113, 22727.77272227323, 22832.0, 22838.086476541415, 35607.64392356147, 37347.25305493929, 37385.0, 37403.81298093492, 41726.37410438906, 180799.09600451915, 400678.0, 405804.0, 409915.0, 409925.0, 28975.5653665191, 29758.25604359908, 29817.0, 29833.552496713, 30024.249393764458, 41161.0, 41758.791206043774, 41902.0, 42554.78722606491, 42691.57308427, 34612.65458326187, 34949.0, 35041.474377883846, 35257.471137932436, 35610.82194589011, 33630.3273934515, 35310.75829689708, 35850.28299434049, 35975.0, 36030.4595431074, 28524.286892827844, 29155.0, 29170.0, 29284.0, 29359.0, 27450.0, 28387.290317741397, 29354.706452935196, 31504.842475787475, 34076.0, 20773.584528309046, 21124.89437552864, 21218.151273949486, 21228.57542849165, 21259.46851328729], "unit": "score", "name": "ext.html", "value": 17103.408231773825}, {"lowerIsBetter": false, "replicates": [366.251016670908, 366.5601278465842, 366.8972687647459, 367.426814169895, 375.89474947014844, 13581.864181358183, 13684.11053281536, 15431.845681543182, 16218.513444596652, 16945.830541694595, 15314.923425382885, 15369.462068827594, 16048.43830465934, 16680.41618543351, 16808.915955420205, 5247.553957913582, 5447.12845944649, 5450.754716037768, 5453.590980676446, 5455.645383050089, 3911.2373087247997, 4114.321137012389, 5289.259503669489, 5414.91877621836, 5649.435056494359, 5708.422164219258, 5764.394738552433, 5824.737886795105, 5824.883502329951, 5825.359210486843, 5699.458551437607, 5895.233619629421, 5926.97036514819, 5928.170056192136, 5930.970345148268, 4919.385076865392, 5084.593232541425, 5085.644004919657, 5236.266922630834, 5240.528352448298, 12735.235885846787, 12897.935510322483, 16228.918855405647, 20125.0, 20125.194992200293, 1908.8377487913544, 1930.9710354344695, 1989.8706584071988, 2035.4911272181955, 2036.2262340310735, 12772.744545109046, 13081.86918130816, 13251.13867598603, 13557.525486607921, 13703.177809331472, 1811.9094045297813, 1833.5782769962984, 1877.7652793400825, 1914.8755330903446, 1923.2691577200715, 62902.68548657227, 63389.0, 65419.018714719794, 65557.67221163864, 65669.0, 14662.780058299135, 14707.908583523766, 14778.92610536962, 14862.405503779944, 15248.618784530476, 13269.535566255136, 13645.11306765077, 23095.422614434436, 23195.420114497272, 23246.861673674175, 7282.235365286675, 7433.033705618235, 7536.434767392468, 7581.924180758122, 7596.734114305973, 7151.713931442684, 7171.354578087997, 7224.67488962998, 7234.674439650228, 7237.059182306267, 4224.938972551291, 4263.8081286342185, 4514.413126293561, 4532.5694059064335, 4594.65540084495, 1798.2627122879558, 1824.1700026487915, 1836.1610079945633, 1849.7687789026372, 1907.418237437567, 679.4109793605342, 768.3737753730692, 768.5350363030398, 806.3226889412921, 834.7746108550657, 14154.150750954976, 14465.49370772039, 14644.560663180122, 14817.70364592702, 14832.11007339563, 774.6397924964806, 789.4434423731255, 794.8966634337614, 802.5465611929242, 809.2918696140877, 8499.277561407225, 8604.13958604147, 8944.463332200088, 9047.90952090484, 9215.44707317563, 339213.0, 339640.0, 468304.0, 472627.0, 475501.0, 43929.34105988413, 64691.70616587642, 67134.66432667806, 70978.64510677516, 71648.0, 1126.3523474002482, 1129.836173754801, 1138.607180522735, 1140.7091191746051, 1150.4075401168404, 12750.68123296925, 13185.60443186706, 13605.863941360856, 13762.24307663088, 13892.305384730926, 29536.409271814875, 30011.399772004876, 30235.732320076524, 30657.846710766302, 31342.52986205163, 37917.0, 38670.0, 39157.0, 39331.2133757329, 39459.2108157841, 3041.5893854330266, 6576.145101137013, 7147.785566433015, 7194.604296763729, 7436.553806771611, 9502.809943801223, 9935.503224838874, 10368.637097701545, 10506.264561480928, 10662.147028237567, 8276.599786061975, 8489.533075680896, 8504.872426913478, 8782.648694052166, 8807.339449541438, 6291.748330066929, 6785.864282714219, 7079.964600176966, 7100.147982242164, 8625.95687021586, 6683.198016238082, 6717.899231511629, 6797.218319893275, 6878.58728476293, 6900.206476255295, 9859.654912078044, 9863.0, 9891.2581556385, 10008.349457285252, 10061.195104391485, 9036.502992335485, 9055.18503334703, 9181.816363672555, 9253.953730231575, 9382.81234375295], "unit": "score", "name": "jquery.html", "value": 7945.663153350531}, {"lowerIsBetter": false, "replicates": [1346.6229455752393, 1436.2029073864, 1442.1995792335254, 1595.7127717010933, 1792.399546152039, 7013.3337332953415, 7677.769666909995, 7802.10275818281, 7809.062912450499, 7814.960925195381, 7672.616369181533, 7871.80320491988, 7897.802554936129, 7900.130985591581, 7904.249096335839, 2011.175418078588, 2052.507398224423, 2278.111536500766, 2280.281711260952, 2306.5732839424677, 2304.4584522637165, 2308.4921317310163, 2313.2828823064906, 2313.6529520571967, 2314.618088015475, 2248.87631180285, 2310.0875154314035, 2329.7320808107115, 2331.5453486570127, 2331.720193576773, 2255.639097744361, 2308.6421604651305, 2311.4105902994797, 2319.443333599924, 2319.5708793873105, 2240.025588868831, 2251.0883092347626, 2256.548690261954, 2293.793558579736, 2358.009635952904, 7949.682012719484, 7999.1600881907725, 8008.359331253486, 8011.839763204704, 8034.236747508978, 4581.885452863672, 4649.04694537619, 4664.207084795593, 4668.766561671903, 4673.462551806518, 2998.14552852436, 3005.4119121267363, 3068.9079327620207, 3137.450946084426, 3176.7140957313954, 940.0740270833223, 944.7543638653931, 978.6623614852864, 981.2738573455663, 994.8656931314252, 10728.73178170544, 10753.677389678322, 10772.138228941743, 10772.192085593533, 10778.892211077868, 4293.97853010733, 4340.348947657877, 4399.38408622793, 4405.0969551241915, 4413.713108647928, 9309.534523273946, 9320.394174378644, 9321.254299656011, 9322.813543729088, 9325.694402783616, 4819.95180048202, 4830.154722923475, 4858.489858564871, 4865.0, 4865.099956508057, 4396.626286765597, 4398.472183337956, 4406.5593440655675, 4406.625436837905, 4409.162259170747, 3438.793672379615, 3496.877609283663, 3610.891673249807, 3621.5654121505063, 3646.21606354635, 1240.1319076646203, 1240.2434514945876, 1243.3907385381099, 1250.7310928150491, 1254.4229654358915, 904.968326108583, 919.1589695428607, 919.2048877720723, 943.8725772020689, 1251.6620512461766, 7026.191987921455, 7048.92951070493, 7050.0, 7054.5061845671335, 7054.576725396492, 945.2107490245585, 954.4845783276953, 959.6536468334855, 969.7575606098476, 980.9362391444533, 5603.271574695264, 5668.688222147739, 5689.175069614966, 5689.68706721126, 5691.743871525791, 9190.08099190089, 9352.485613291334, 9481.857772133424, 9489.572969216402, 9497.43015419077, 9307.953460232655, 9318.72043838686, 9324.160825525736, 9354.95322523383, 9355.298352623444, 7222.783316500513, 7402.1487528933785, 7405.259763955466, 7405.518641288407, 7408.185099639036, 7021.368076873106, 7066.258042905626, 7138.892916606152, 7163.426925845815, 7167.319104685047, 8232.217939295757, 8359.874601880854, 8433.662653493791, 8436.915630843612, 8445.577721114043, 8627.611757470804, 8737.169968852948, 8744.081871403665, 8751.343649226461, 8756.211940925092, 6224.533160012927, 6993.615351155735, 7065.682044307916, 7099.645017749195, 7111.573305601681, 6819.147606549182, 7144.892826607501, 7334.3032411920785, 7350.338469537767, 7372.963135184505, 6875.312468753084, 6992.825179370557, 7049.859002820018, 7072.858542829217, 7155.248698886542, 6796.66016699173, 6833.214180369122, 6842.486813489108, 6915.066466027223, 6948.0272761812375, 6632.734690612515, 6673.733050677918, 6682.398584127452, 6695.866082678416, 6769.086173366532, 6325.177726895658, 6373.426391624776, 6375.681215939092, 6378.77674281398, 6379.425851673372, 6328.493720502257, 6361.491080713439, 6364.109024736633, 6365.236171659245, 6374.681265936777], "unit": "score", "name": "mootools.html", "value": 4446.733868517209}, {"lowerIsBetter": false, "replicates": [326.75166873176386, 332.396699989519, 337.11171064245707, 337.8834302165753, 342.76349318969926, 5709.543236541077, 5869.295684517859, 5879.412058794119, 5890.587658863876, 5892.88214235715, 5696.515796157321, 5829.708514574276, 5844.357120716729, 5863.618864773786, 5870.559708021894, 4577.885552861172, 4578.290364993423, 4578.336141259515, 4578.748168850712, 4578.862634120982, 4377.409049778287, 4452.866414007585, 4479.776011199443, 4482.394876691637, 4572.291294849287, 4433.889152771174, 4462.955370446302, 4501.887452813689, 4507.188706032913, 4513.435820522434, 4488.618467430256, 4489.451139356916, 4492.0791237796175, 4494.752788596626, 4500.0774841157645, 3950.8814735557694, 3966.702497312684, 3969.7419667721506, 3971.3645816669195, 3972.801359931992, 5484.287042684466, 5550.666959982414, 5570.777168913279, 5577.8047768327915, 5581.274434323512, 5209.0363282792805, 5210.348706411699, 5215.217717342391, 5234.92147617786, 5261.421243663232, 5924.7333869975955, 6227.532935029891, 6242.531810114214, 6245.531585131133, 6256.0, 4318.071614602875, 4367.868963931087, 4400.22995975703, 4405.581469760367, 4423.292273236267, 6394.6482943438095, 6455.289918109004, 6490.545661803676, 6500.414962653336, 6509.739610415578, 4477.574630410106, 4502.864914052584, 4503.211937910853, 4506.3916371290115, 4516.887077823015, 4480.103979204172, 4565.931511027337, 4566.520515345907, 4572.885677858014, 4588.678792484561, 5199.610029247821, 5211.088059589557, 5214.582833373397, 5248.553872920845, 5251.973740131351, 6257.217847769029, 6269.78055768055, 6274.341194174637, 6276.058591211355, 6278.058291256348, 1606.3173151410604, 1622.594351412147, 1625.2361390146611, 1625.8211596724586, 1631.5350125214256, 1102.4212288548576, 1107.2083460325905, 1131.7057565032985, 1133.8525991621202, 1139.0545846947014, 5945.048792193228, 5955.612885162451, 5957.165996760457, 5960.046392577166, 5960.254968128984, 6416.871662566816, 6422.903656445157, 6424.550281480345, 6432.807015789534, 6439.9356006440275, 5830.795922142789, 5939.613925094855, 5943.108533719977, 5951.583389162717, 5951.940480595225, 3404.761666683358, 3453.9481907771406, 3462.4460086386057, 3462.532558104674, 3463.0476618929492, 6631.56894801846, 6642.900356494656, 6697.631630260285, 6701.698423570951, 6705.396514313735, 6560.179977502812, 6565.835854103686, 6568.343165683394, 6569.605823650596, 6577.375149360803, 6522.445592124628, 6668.633225172565, 6672.099266599044, 6689.866202675822, 6690.498212634072, 6223.813285601439, 6369.0, 6384.553081284265, 6390.7443702251385, 6396.42432181106, 6286.9371306288185, 6320.494360451245, 6335.334789847, 6349.111124442674, 6349.936500634934, 6709.664516774239, 6728.0, 6729.629870357177, 6735.4274886635185, 6739.292374300628, 4504.414426124714, 4596.965682721361, 4604.953950460453, 4611.6310695144975, 4617.168909596305, 6498.772542960974, 6503.057056726842, 6513.837154071186, 6518.2178138621775, 6521.413072823469, 6276.874462510633, 6305.243370795534, 6324.525660575568, 6338.778142764981, 6346.111544383698, 6126.448619624255, 6288.088227207121, 6300.779472718433, 6300.8109756705535, 6319.24169099711, 6178.104174894525, 6183.690815459299, 6197.318294987457, 6218.9378106218355, 6292.748290068346, 6375.936240637534, 6439.774607888701, 6440.806775796734, 6442.710078046405, 6444.065610486547, 6020.337762845996, 6188.164597779242, 6199.411055949678, 6202.34875338101, 6209.161763161916], "unit": "score", "name": "prototype.html", "value": 4737.908986986606}, {"lowerIsBetter": false, "replicates": [770.7379490973068, 802.4944285100382, 804.8671969125091, 808.959552022399, 826.2316046077148, 11871.169018168732, 12060.035197184226, 12075.094367922396, 12081.697957551065, 12084.033277337803, 11215.327080375184, 11289.266197697143, 11293.265937714063, 11297.548098076088, 11303.886961130387, 768.6041688530397, 791.4934441957153, 809.3323008517967, 809.9959500202491, 810.222186700768, 498.9002199560084, 508.8905885234674, 803.5540275147321, 806.3186607316837, 806.818465845183, 825.9463134896213, 833.0461621443444, 839.4627438439404, 840.155643578203, 840.3487297344545, 803.863343231652, 805.2832978648948, 808.1756608259572, 808.1918081918081, 808.9150639182918, 372.4115896882918, 374.8463130116639, 587.1544975235689, 597.9133025711291, 609.6281268426256, 11800.0, 11816.172867899251, 11839.0, 11849.0, 11852.40737963107, 11001.17491188164, 11505.424728763528, 11591.594294199662, 11946.820797688042, 12279.263244205376, 9133.634654613808, 9500.857487137699, 9769.804603907953, 9952.452615106165, 10021.849672254923, 3350.5644266245477, 3354.3479237484917, 3368.612609549884, 3395.1681837949614, 3482.3035392921265, 46866.76566617145, 46913.06173876538, 47481.0, 47826.760866195444, 47915.0, 8974.596143173572, 9058.184763371197, 9062.320325975577, 9104.0, 9173.128552787475, 16675.749863752055, 16803.663926721398, 16876.83123168777, 16922.661546768995, 17006.659866802842, 6526.28210896801, 6621.3047629998155, 6733.663316834139, 6737.393634572912, 7146.2496437874315, 3544.3265779502326, 3610.981945090258, 3641.016925430119, 3690.372636651776, 3697.371446854041, 2873.0231721214886, 2876.0077773168223, 2906.302487403008, 2916.0668586052684, 2921.985390073036, 531.4897698209685, 588.9293284805851, 603.1706403694919, 604.4559896093463, 605.8061420345535, 499.4880247746017, 506.8428787076018, 510.7650480778809, 610.9205803245638, 662.68522451835, 7355.668994895243, 7450.701971921062, 7592.240775922363, 7716.035495563055, 7817.648205830751, 501.6814322904909, 502.47742347958444, 526.1056204452447, 544.7303584725507, 664.6743095882982, 3480.930381392358, 3535.452004939187, 3641.5448068991377, 3642.1623026704005, 3739.364308067635, 57710.422895770505, 62277.0, 63082.68458657769, 63237.36762632407, 63253.36746632567, 49811.0, 49874.750626246634, 50876.0, 51834.74082629638, 51997.2200416994, 43650.34524482135, 43829.56170438255, 44891.32663010057, 45970.77014614973, 47336.52663473459, 7557.168711441627, 7743.380529557735, 7838.0, 7983.2415920487465, 8045.9597702011115, 29686.406271874872, 30161.547576786805, 30910.0, 31266.843665781525, 31826.0, 38098.61901381062, 38328.42507362336, 40190.19619607533, 41652.79173604112, 41897.79051104725, 10061.496925153566, 10410.427426491313, 10669.519871605951, 10725.731856703645, 10796.082333001783, 11661.183717139718, 11706.941465292619, 11792.174547781573, 11826.408679566159, 12206.328651923874, 9682.419054856731, 9862.260330475387, 9890.950545247228, 10130.240231982778, 10187.185025198114, 10711.678649640524, 10736.570537178426, 10912.236143469881, 11191.767431937069, 11301.15241356885, 10870.293430926964, 10875.184361172785, 11061.281016733887, 11069.944650276697, 11352.091832653203, 8827.382083254368, 8879.644814207359, 8953.32850036263, 9069.455832650063, 9331.393459425115, 8414.789630259293, 9168.862467062865, 9263.490508022123, 9369.859452108087, 9373.591261486528], "unit": "score", "name": "yui.html", "value": 5844.757140989105}], "name": "dromaeo_css", "value": 6636.744442644345}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 108.0, 110.0, 109.0, 111.0, 112.0, 112.0, 105.0, 112.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [151.0, 129.0, 152.0, 173.0, 131.0, 152.0, 149.0, 129.0, 168.0, 134.0], "unit": "score", "name": "audio-beat-detection", "value": 146.8}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 160.0, 160.0, 160.0, 161.0, 159.0, 159.0, 160.0, 161.0], "unit": "score", "name": "audio-dft", "value": 160.3}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 93.0, 93.0, 74.0, 73.0, 73.0, 133.0, 94.0, 73.0], "unit": "score", "name": "audio-fft", "value": 85.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 149.0, 95.0, 94.0, 95.0, 142.0, 95.0, 96.0, 141.0], "unit": "score", "name": "audio-oscillator", "value": 109.8}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 55.0, 55.0, 56.0, 57.0, 57.0, 56.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 69.0, 71.0, 70.0, 69.0, 69.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [83.0, 82.0, 83.0, 83.0, 83.0, 83.0, 85.0, 83.0, 87.0, 82.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.4}, {"lowerIsBetter": true, "replicates": [114.0, 117.0, 121.0, 116.0, 121.0, 113.0, 124.0, 115.0, 115.0, 122.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.8}, {"lowerIsBetter": true, "replicates": [154.0, 140.0, 142.0, 141.0, 155.0, 136.0, 147.0, 141.0, 142.0, 151.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 77.0, 65.0, 66.0, 66.0, 67.0, 65.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1502.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.6727028839705], "unit": "score", "name": "Richards", "value": 210.54112800000007}, {"lowerIsBetter": false, "replicates": [191.75455417066155], "unit": "score", "name": "DeltaBlue", "value": 344.80537}, {"lowerIsBetter": false, "replicates": [281.29395218002816], "unit": "score", "name": "Encrypt", "value": 946.2734550000002}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1131.2217194570135], "unit": "score", "name": "RayTrace", "value": 654.1502760000003}, {"lowerIsBetter": false, "replicates": [796.1783439490446], "unit": "score", "name": "Earley", "value": 837.077528}, {"lowerIsBetter": false, "replicates": [12419.753086419752], "unit": "score", "name": "Boyer", "value": 53.66153379721673}, {"lowerIsBetter": false, "replicates": [42062.5], "unit": "score", "name": "RegExp", "value": 21.657890044576536}, {"lowerIsBetter": false, "replicates": [577.0340450086555], "unit": "score", "name": "Splay", "value": 141.22390300000004}, {"lowerIsBetter": false, "replicates": [4817.307692307692], "unit": "score", "name": "NavierStokes", "value": 308.055888223553}], "name": "v8_7", "value": 20013.697047260524}]} 23:12:20 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,201,35]]", "result": "20013.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,201,35]]", "result": "1502.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,201,35]]", "result": "6636.74"}}} 23:12:20 INFO - Return code: 0 23:12:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 23:12:20 INFO - # TBPL SUCCESS # 23:12:20 INFO - Running post-action listener: _resource_record_post_action 23:12:20 INFO - Running post-run listener: _resource_record_post_run 23:12:22 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 545505280; Read time: 0; Write time: 386956 23:12:22 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 245526528; Read time: 0; Write time: 207344 23:12:22 INFO - run-tests - Wall time: 1214s; CPU: 13.0%; Read bytes: 0; Write bytes: 299978752; Read time: 0; Write time: 179612 23:12:22 INFO - Running post-run listener: _upload_blobber_files 23:12:22 INFO - Blob upload gear active. 23:12:22 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 23:12:22 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 23:12:22 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', 'B2G-Inbound', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 23:12:22 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 B2G-Inbound -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 23:12:22 INFO - (blobuploader) - INFO - Open directory for files ... 23:12:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:12:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:12:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:23 INFO - (blobuploader) - INFO - Done attempting. 23:12:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs_raw.log ... 23:12:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:12:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:12:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:12:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:12:24 INFO - (blobuploader) - INFO - Done attempting. 23:12:24 INFO - (blobuploader) - INFO - Iteration through files over. 23:12:24 INFO - Return code: 0 23:12:24 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 23:12:24 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 23:12:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7b2f6deb0db539b5113d9447e10ad39ab1df4e1aaf79e7224c13da30802862728d5a63863cc42ea332ebab79a94c73d41ed199c89cbf542ba662887124fc21aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/568710a72966263c0fb3c844718ddcb322d3d6525888cf883f8a1f59e6628fa6f23aa4416eba7e25f719a14cbc93f57a1369dcc365427420c12cbc46acf80588"} 23:12:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 23:12:24 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 23:12:24 INFO - Contents: 23:12:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7b2f6deb0db539b5113d9447e10ad39ab1df4e1aaf79e7224c13da30802862728d5a63863cc42ea332ebab79a94c73d41ed199c89cbf542ba662887124fc21aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/568710a72966263c0fb3c844718ddcb322d3d6525888cf883f8a1f59e6628fa6f23aa4416eba7e25f719a14cbc93f57a1369dcc365427420c12cbc46acf80588"} 23:12:24 INFO - Running post-run listener: copy_logs_to_upload_dir 23:12:24 INFO - Copying logs to upload dir... 23:12:24 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 23:12:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1267.790369 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2016-01-21 23:12:24.217602) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 23:12:24.220665) ========= 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-1453442800.921636-1613417998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7b2f6deb0db539b5113d9447e10ad39ab1df4e1aaf79e7224c13da30802862728d5a63863cc42ea332ebab79a94c73d41ed199c89cbf542ba662887124fc21aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/568710a72966263c0fb3c844718ddcb322d3d6525888cf883f8a1f59e6628fa6f23aa4416eba7e25f719a14cbc93f57a1369dcc365427420c12cbc46acf80588"} build_url:https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011319 build_url: 'https://queue.taskcluster.net/v1/task/cssd5Yl-SRqC3idQDyqL-A/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/7b2f6deb0db539b5113d9447e10ad39ab1df4e1aaf79e7224c13da30802862728d5a63863cc42ea332ebab79a94c73d41ed199c89cbf542ba662887124fc21aa", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/B2G-Inbound/sha512/568710a72966263c0fb3c844718ddcb322d3d6525888cf883f8a1f59e6628fa6f23aa4416eba7e25f719a14cbc93f57a1369dcc365427420c12cbc46acf80588"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-01-21 23:12:24.245039) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:12:24.245366) ========= 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-1453442800.921636-1613417998 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004558 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-01-21 23:12:24.331847) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 23:12:24.332178) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-01-21 23:12:24.332496) ========= ========= Total master_lag: 2.86 =========