builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1456578605.1 results: success (0) buildid: 20160225002727 builduid: ddb4a69f92634164953fbb89635fa9b7 revision: b131aaab8f2f65db173486af71fe969c5ceff6da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.102162) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.102664) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.102952) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.003703 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.118539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.118877) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.128024) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.129639) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003939 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.177760) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.178123) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.178541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.178905) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 05:10:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2016-02-27 05:10:06 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167460 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.359098) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.359628) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017756 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.411044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:05.411393) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b131aaab8f2f65db173486af71fe969c5ceff6da --destination scripts --debug' in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev b131aaab8f2f65db173486af71fe969c5ceff6da --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=5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 05:10:06,680 truncating revision to first 12 chars 2016-02-27 05:10:06,680 Setting DEBUG logging. 2016-02-27 05:10:06,680 attempt 1/10 2016-02-27 05:10:06,680 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/b131aaab8f2f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-27 05:10:06,972 unpacking tar archive at: mozilla-aurora-b131aaab8f2f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.595801 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:06.024643) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:06.025280) ========= echo b131aaab8f2f65db173486af71fe969c5ceff6da in dir /builds/slave/test-pgo/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'b131aaab8f2f65db173486af71fe969c5ceff6da'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b131aaab8f2f65db173486af71fe969c5ceff6da program finished with exit code 0 elapsedTime=0.004669 script_repo_revision: 'b131aaab8f2f65db173486af71fe969c5ceff6da' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:06.080394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:06.080991) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:06.092509) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-27 05:10:06.093140) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test-pgo/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test-pgo/buildprops.json PWD=/builds/slave/test-pgo SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:07 INFO - MultiFileLogger online at 20160227 05:10:07 in /builds/slave/test-pgo 05:10:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:10:07 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:10:07 INFO - {'append_to_log': False, 05:10:07 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:10:07 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:10:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:10:07 INFO - 'branch': 'Mozilla-Aurora', 05:10:07 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:07 INFO - 'config_files': ('talos/linux_config.py',), 05:10:07 INFO - 'default_actions': ('clobber', 05:10:07 INFO - 'read-buildbot-config', 05:10:07 INFO - 'download-and-extract', 05:10:07 INFO - 'populate-webroot', 05:10:07 INFO - 'create-virtualenv', 05:10:07 INFO - 'install', 05:10:07 INFO - 'run-tests'), 05:10:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:07 INFO - 'download_minidump_stackwalk': True, 05:10:07 INFO - 'download_symbols': 'ondemand', 05:10:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:07 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:07 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:07 INFO - 'installer_path': 'installer.exe', 05:10:07 INFO - 'log_level': 'info', 05:10:07 INFO - 'log_name': 'talos', 05:10:07 INFO - 'log_to_console': True, 05:10:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:07 INFO - 'opt_config_files': (), 05:10:07 INFO - 'pip_index': False, 05:10:07 INFO - 'sps_profile': False, 05:10:07 INFO - 'sps_profile_interval': 0, 05:10:07 INFO - 'suite': 'dromaeojs-e10s', 05:10:07 INFO - 'system_bits': '32', 05:10:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:07 INFO - 'title': 'talos-linux64-ix-051', 05:10:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:07 INFO - 'use_talos_json': True, 05:10:07 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:10:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:07 INFO - 'work_dir': 'build'} 05:10:07 INFO - ##### 05:10:07 INFO - ##### Running clobber step. 05:10:07 INFO - ##### 05:10:07 INFO - Running pre-action listener: _resource_record_pre_action 05:10:07 INFO - Running main action method: clobber 05:10:07 INFO - rmtree: /builds/slave/test-pgo/build 05:10:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:10:08 INFO - Running post-action listener: _resource_record_post_action 05:10:08 INFO - ##### 05:10:08 INFO - ##### Running read-buildbot-config step. 05:10:08 INFO - ##### 05:10:08 INFO - Running pre-action listener: _resource_record_pre_action 05:10:08 INFO - Running main action method: read_buildbot_config 05:10:08 INFO - Using buildbot properties: 05:10:08 INFO - { 05:10:08 INFO - "project": "", 05:10:08 INFO - "product": "firefox", 05:10:08 INFO - "script_repo_revision": "production", 05:10:08 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:10:08 INFO - "repository": "", 05:10:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:10:08 INFO - "buildid": "20160225002727", 05:10:08 INFO - "pgo_build": "True", 05:10:08 INFO - "basedir": "/builds/slave/test-pgo", 05:10:08 INFO - "buildnumber": 165, 05:10:08 INFO - "slavename": "talos-linux64-ix-051", 05:10:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:10:08 INFO - "platform": "ubuntu64_hw", 05:10:08 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:10:08 INFO - "branch": "mozilla-aurora", 05:10:08 INFO - "repo_path": "releases/mozilla-aurora", 05:10:08 INFO - "revision": "b131aaab8f2f65db173486af71fe969c5ceff6da", 05:10:08 INFO - "stage_platform": "linux64-pgo", 05:10:08 INFO - "builduid": "ddb4a69f92634164953fbb89635fa9b7", 05:10:08 INFO - "slavebuilddir": "test" 05:10:08 INFO - } 05:10:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2. 05:10:08 INFO - Running post-action listener: _resource_record_post_action 05:10:08 INFO - ##### 05:10:08 INFO - ##### Running download-and-extract step. 05:10:08 INFO - ##### 05:10:08 INFO - Running pre-action listener: _resource_record_pre_action 05:10:08 INFO - Running main action method: download_and_extract 05:10:08 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:10:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:08 INFO - https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:10:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/test_packages.json 05:10:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/test_packages.json 05:10:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/test_packages.json to /builds/slave/test-pgo/build/test_packages.json 05:10:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test-pgo/build/test_packages.json'}, attempt #1 05:10:09 INFO - Downloaded 1448 bytes. 05:10:09 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:10:09 INFO - Using the following test package requirements: 05:10:09 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:10:09 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:09 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:09 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:09 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:10:09 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:09 INFO - u'jsshell-linux-x86_64.zip'], 05:10:09 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:09 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:09 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:10:09 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:09 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:10:09 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:09 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:10:09 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:09 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:09 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:10:09 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:09 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:09 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:09 INFO - https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:10:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:10:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:10:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:10:10 INFO - Downloaded 23079153 bytes. 05:10:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:10:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:10:11 INFO - Return code: 0 05:10:11 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:11 INFO - https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip 05:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:10:12 INFO - Downloaded 23079153 bytes. 05:10:12 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:10:12 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:10:13 INFO - Return code: 0 05:10:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:13 INFO - https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:10:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:10:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:10:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip 05:10:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:10:14 INFO - Downloaded 10706572 bytes. 05:10:14 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:10:14 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:10:15 INFO - Return code: 0 05:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:15 INFO - https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:10:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:10:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:10:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:10:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:10:16 INFO - Downloaded 59961105 bytes. 05:10:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:10:16 INFO - mkdir: /builds/slave/test-pgo/properties 05:10:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:10:16 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:10:16 INFO - Contents: 05:10:16 INFO - build_url:https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 05:10:17 INFO - Running post-action listener: _resource_record_post_action 05:10:17 INFO - Running post-action listener: set_extra_try_arguments 05:10:17 INFO - ##### 05:10:17 INFO - ##### Running populate-webroot step. 05:10:17 INFO - ##### 05:10:17 INFO - Running pre-action listener: _resource_record_pre_action 05:10:17 INFO - Running main action method: populate_webroot 05:10:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:17 INFO - '--tppagecycles', 05:10:17 INFO - '7'], 05:10:17 INFO - 'tests': ['tsvgm']}}, 05:10:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:10:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'tests': ['damp', 'tps']}, 05:10:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['damp', 'tps']}, 05:10:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:10:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:17 INFO - 'other': {'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other_l64': {'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'other_nol64': {'tests': ['a11yr', 05:10:17 INFO - 'ts_paint', 05:10:17 INFO - 'tpaint', 05:10:17 INFO - 'sessionrestore', 05:10:17 INFO - 'sessionrestore_no_auto_restore']}, 05:10:17 INFO - 'svgr': {'tests': ['tsvgx', 05:10:17 INFO - 'tsvgr_opacity', 05:10:17 INFO - 'tart', 05:10:17 INFO - 'tscrollx', 05:10:17 INFO - 'cart']}, 05:10:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['tsvgx', 05:10:17 INFO - 'tsvgr_opacity', 05:10:17 INFO - 'tart', 05:10:17 INFO - 'tscrollx', 05:10:17 INFO - 'cart']}, 05:10:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'tests': ['tp5o']}, 05:10:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--e10s'], 05:10:17 INFO - 'tests': ['tp5o']}, 05:10:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--xperf_path', 05:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:17 INFO - 'tests': ['tp5n']}, 05:10:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:17 INFO - 'talos_options': ['--e10s', 05:10:17 INFO - '--xperf_path', 05:10:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:17 INFO - 'tests': ['tp5n']}}, 05:10:17 INFO - 'talos.zip': {'path': '', 05:10:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:17 INFO - Running post-action listener: _resource_record_post_action 05:10:17 INFO - ##### 05:10:17 INFO - ##### Running create-virtualenv step. 05:10:17 INFO - ##### 05:10:17 INFO - Running pre-action listener: _resource_record_pre_action 05:10:17 INFO - Running main action method: create_virtualenv 05:10:17 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:10:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test-pgo/build/venv'] in /builds/slave/test-pgo/build 05:10:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:10:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:17 INFO - Using real prefix '/usr' 05:10:17 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:10:17 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:19 INFO - Installing pip.................done. 05:10:19 INFO - Return code: 0 05:10:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:19 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb918377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:19 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test-pgo/build 05:10:19 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:10:19 INFO - Using env: {'DISPLAY': ':0', 05:10:19 INFO - 'HOME': '/home/cltbld', 05:10:19 INFO - 'LANG': 'en_US.UTF-8', 05:10:19 INFO - 'LANGUAGE': 'en_US:en', 05:10:19 INFO - 'LOGNAME': 'cltbld', 05:10:19 INFO - 'MAIL': '/var/mail/cltbld', 05:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:19 INFO - 'MOZ_NO_REMOTE': '1', 05:10:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:19 INFO - 'NO_EM_RESTART': '1', 05:10:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:19 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:19 INFO - 'SHELL': '/bin/bash', 05:10:19 INFO - 'SHLVL': '1', 05:10:19 INFO - 'TERM': 'linux', 05:10:19 INFO - 'TMOUT': '86400', 05:10:19 INFO - 'USER': 'cltbld', 05:10:19 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:19 INFO - '_': '/tools/buildbot/bin/python'} 05:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:10:20 INFO - Cleaning up... 05:10:20 INFO - Return code: 0 05:10:20 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:20 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 0x7fb918377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:20 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test-pgo/build 05:10:20 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:10:20 INFO - Using env: {'DISPLAY': ':0', 05:10:20 INFO - 'HOME': '/home/cltbld', 05:10:20 INFO - 'LANG': 'en_US.UTF-8', 05:10:20 INFO - 'LANGUAGE': 'en_US:en', 05:10:20 INFO - 'LOGNAME': 'cltbld', 05:10:20 INFO - 'MAIL': '/var/mail/cltbld', 05:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:20 INFO - 'MOZ_NO_REMOTE': '1', 05:10:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:20 INFO - 'NO_EM_RESTART': '1', 05:10:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:20 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:20 INFO - 'SHELL': '/bin/bash', 05:10:20 INFO - 'SHLVL': '1', 05:10:20 INFO - 'TERM': 'linux', 05:10:20 INFO - 'TMOUT': '86400', 05:10:20 INFO - 'USER': 'cltbld', 05:10:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:20 INFO - '_': '/tools/buildbot/bin/python'} 05:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:20 INFO - Downloading/unpacking psutil>=0.7.1 05:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:22 INFO - Installing collected packages: psutil 05:10:22 INFO - Running setup.py install for psutil 05:10:22 INFO - building 'psutil._psutil_linux' extension 05:10:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:10:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:10:22 INFO - building 'psutil._psutil_posix' extension 05:10:22 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:10:22 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:10:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:22 INFO - Successfully installed psutil 05:10:22 INFO - Cleaning up... 05:10:22 INFO - Return code: 0 05:10:22 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test-pgo/build/venv 05:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:22 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 0x7fb918377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:22 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test-pgo/build 05:10:22 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:10:22 INFO - Using env: {'DISPLAY': ':0', 05:10:22 INFO - 'HOME': '/home/cltbld', 05:10:22 INFO - 'LANG': 'en_US.UTF-8', 05:10:22 INFO - 'LANGUAGE': 'en_US:en', 05:10:22 INFO - 'LOGNAME': 'cltbld', 05:10:22 INFO - 'MAIL': '/var/mail/cltbld', 05:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:22 INFO - 'MOZ_NO_REMOTE': '1', 05:10:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:22 INFO - 'NO_EM_RESTART': '1', 05:10:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:22 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:22 INFO - 'SHELL': '/bin/bash', 05:10:22 INFO - 'SHLVL': '1', 05:10:22 INFO - 'TERM': 'linux', 05:10:22 INFO - 'TMOUT': '86400', 05:10:22 INFO - 'USER': 'cltbld', 05:10:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:22 INFO - '_': '/tools/buildbot/bin/python'} 05:10:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:10:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:10:24 INFO - Installing collected packages: mozsystemmonitor 05:10:24 INFO - Running setup.py install for mozsystemmonitor 05:10:25 INFO - Successfully installed mozsystemmonitor 05:10:25 INFO - Cleaning up... 05:10:25 INFO - Return code: 0 05:10:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test-pgo/build/venv 05:10: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')]} 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10: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')]} 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:25 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 0x7fb918377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:25 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test-pgo/build 05:10:25 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:10:25 INFO - Using env: {'DISPLAY': ':0', 05:10:25 INFO - 'HOME': '/home/cltbld', 05:10:25 INFO - 'LANG': 'en_US.UTF-8', 05:10:25 INFO - 'LANGUAGE': 'en_US:en', 05:10:25 INFO - 'LOGNAME': 'cltbld', 05:10:25 INFO - 'MAIL': '/var/mail/cltbld', 05:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:25 INFO - 'MOZ_NO_REMOTE': '1', 05:10:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:25 INFO - 'NO_EM_RESTART': '1', 05:10:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:25 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:25 INFO - 'SHELL': '/bin/bash', 05:10:25 INFO - 'SHLVL': '1', 05:10:25 INFO - 'TERM': 'linux', 05:10:25 INFO - 'TMOUT': '86400', 05:10:25 INFO - 'USER': 'cltbld', 05:10:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:25 INFO - '_': '/tools/buildbot/bin/python'} 05:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:10:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:10:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:27 INFO - Downloading docopt-0.6.1.tar.gz 05:10:27 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:27 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:27 INFO - Running setup.py install for blobuploader 05:10:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:27 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:10:27 INFO - Running setup.py install for requests 05:10:28 INFO - Running setup.py install for docopt 05:10:28 INFO - Successfully installed blobuploader requests docopt 05:10:28 INFO - Cleaning up... 05:10:28 INFO - Return code: 0 05:10:28 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:28 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 0x7fb918377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:28 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:10:28 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:28 INFO - Using env: {'DISPLAY': ':0', 05:10:28 INFO - 'HOME': '/home/cltbld', 05:10:28 INFO - 'LANG': 'en_US.UTF-8', 05:10:28 INFO - 'LANGUAGE': 'en_US:en', 05:10:28 INFO - 'LOGNAME': 'cltbld', 05:10:28 INFO - 'MAIL': '/var/mail/cltbld', 05:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:28 INFO - 'MOZ_NO_REMOTE': '1', 05:10:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:28 INFO - 'NO_EM_RESTART': '1', 05:10:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:28 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:28 INFO - 'SHELL': '/bin/bash', 05:10:28 INFO - 'SHLVL': '1', 05:10:28 INFO - 'TERM': 'linux', 05:10:28 INFO - 'TMOUT': '86400', 05:10:28 INFO - 'USER': 'cltbld', 05:10:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:28 INFO - '_': '/tools/buildbot/bin/python'} 05:10:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:28 INFO - Running setup.py (path:/tmp/pip-TDAFZh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:28 INFO - Running setup.py (path:/tmp/pip-kNghzs-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:28 INFO - Running setup.py (path:/tmp/pip-fa_Dvf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:28 INFO - Running setup.py (path:/tmp/pip-Rua9Iz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:28 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:28 INFO - Running setup.py (path:/tmp/pip-nJJgo9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:29 INFO - Running setup.py (path:/tmp/pip-9zU_FY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:29 INFO - Running setup.py (path:/tmp/pip-Hgvyth-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:29 INFO - Running setup.py (path:/tmp/pip-Dvg4Vi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:29 INFO - Running setup.py (path:/tmp/pip-YCAW2Q-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:29 INFO - Running setup.py (path:/tmp/pip-bGLKcq-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:29 INFO - Running setup.py (path:/tmp/pip-fBCx5y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:29 INFO - Running setup.py (path:/tmp/pip-rEUJpj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:29 INFO - Running setup.py (path:/tmp/pip-mj4TNX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:29 INFO - Running setup.py (path:/tmp/pip-vNHuoh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:29 INFO - Running setup.py (path:/tmp/pip-j0OFw2-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:29 INFO - Running setup.py (path:/tmp/pip-FQHvTU-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:29 INFO - Running setup.py (path:/tmp/pip-XD52Jl-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:29 INFO - Running setup.py install for manifestparser 05:10:29 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Running setup.py install for mozcrash 05:10:30 INFO - Running setup.py install for mozdebug 05:10:30 INFO - Running setup.py install for mozdevice 05:10:30 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Running setup.py install for mozfile 05:10:30 INFO - Running setup.py install for mozhttpd 05:10:30 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Running setup.py install for mozinfo 05:10:30 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Running setup.py install for mozInstall 05:10:30 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Running setup.py install for mozleak 05:10:30 INFO - Running setup.py install for mozlog 05:10:30 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:10:30 INFO - Running setup.py install for moznetwork 05:10:31 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:10:31 INFO - Running setup.py install for mozprocess 05:10:31 INFO - Running setup.py install for mozprofile 05:10:31 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:10:31 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:10:31 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:10:31 INFO - Running setup.py install for mozrunner 05:10:31 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:10:31 INFO - Running setup.py install for mozscreenshot 05:10:31 INFO - Running setup.py install for moztest 05:10:31 INFO - Running setup.py install for mozversion 05:10:31 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:10:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:31 INFO - Cleaning up... 05:10:31 INFO - Return code: 0 05:10:31 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:31 INFO - retry: Calling run_command with args: [['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/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 0x7fb918377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:31 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/config 05:10:31 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:31 INFO - Using env: {'DISPLAY': ':0', 05:10:31 INFO - 'HOME': '/home/cltbld', 05:10:31 INFO - 'LANG': 'en_US.UTF-8', 05:10:31 INFO - 'LANGUAGE': 'en_US:en', 05:10:31 INFO - 'LOGNAME': 'cltbld', 05:10:31 INFO - 'MAIL': '/var/mail/cltbld', 05:10:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:31 INFO - 'MOZ_NO_REMOTE': '1', 05:10:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:31 INFO - 'NO_EM_RESTART': '1', 05:10:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:31 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:31 INFO - 'SHELL': '/bin/bash', 05:10:31 INFO - 'SHLVL': '1', 05:10:31 INFO - 'TERM': 'linux', 05:10:31 INFO - 'TMOUT': '86400', 05:10:31 INFO - 'USER': 'cltbld', 05:10:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:31 INFO - '_': '/tools/buildbot/bin/python'} 05:10:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:31 INFO - Running setup.py (path:/tmp/pip-ugeVzz-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 1)) 05:10:31 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:31 INFO - Running setup.py (path:/tmp/pip-Wmc_sD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:32 INFO - Running setup.py (path:/tmp/pip-vETdY6-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:32 INFO - Running setup.py (path:/tmp/pip-nDFIBw-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:32 INFO - Running setup.py (path:/tmp/pip-CJTABu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 5)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:32 INFO - Running setup.py (path:/tmp/pip-VPDPLb-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 6)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:32 INFO - Running setup.py (path:/tmp/pip-kayRuu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 7)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:32 INFO - Running setup.py (path:/tmp/pip-4i6Hxi-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 8)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:32 INFO - Running setup.py (path:/tmp/pip-m1bBsO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 9)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:32 INFO - Running setup.py (path:/tmp/pip-4h8Gxv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:32 INFO - Running setup.py (path:/tmp/pip-vfFW5d-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 11)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:32 INFO - Running setup.py (path:/tmp/pip-yLpEFB-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 12)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:32 INFO - Running setup.py (path:/tmp/pip-zcj4ix-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 13)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:32 INFO - Running setup.py (path:/tmp/pip-_MMGYd-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 14)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:32 INFO - Running setup.py (path:/tmp/pip-VQzz7p-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 15)) 05:10:32 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:32 INFO - Running setup.py (path:/tmp/pip-VnG_N_-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test-pgo/build/tests/mozbase/moztest in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 16)) 05:10:33 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:33 INFO - Running setup.py (path:/tmp/pip-u7RIEj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 17)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 2)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 3)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 4)) 05:10:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test-pgo/build/tests/config/mozbase_requirements.txt (line 10)) 05:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:34 INFO - Downloading blessings-1.6.tar.gz 05:10:34 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:35 INFO - Installing collected packages: blessings 05:10:35 INFO - Running setup.py install for blessings 05:10:35 INFO - Successfully installed blessings 05:10:35 INFO - Cleaning up... 05:10:35 INFO - Return code: 0 05:10:35 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:10:35 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:10:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:10:35 INFO - Reading from file tmpfile_stdout 05:10:35 INFO - Current package versions: 05:10:35 INFO - argparse == 1.2.1 05:10:35 INFO - blessings == 1.6 05:10:35 INFO - blobuploader == 1.2.4 05:10:35 INFO - docopt == 0.6.1 05:10:35 INFO - manifestparser == 1.1 05:10:35 INFO - mozInstall == 1.12 05:10:35 INFO - mozcrash == 0.16 05:10:35 INFO - mozdebug == 0.1 05:10:35 INFO - mozdevice == 0.48 05:10:35 INFO - mozfile == 1.2 05:10:35 INFO - mozhttpd == 0.7 05:10:35 INFO - mozinfo == 0.9 05:10:35 INFO - mozleak == 0.1 05:10:35 INFO - mozlog == 3.1 05:10:35 INFO - moznetwork == 0.27 05:10:35 INFO - mozprocess == 0.22 05:10:35 INFO - mozprofile == 0.28 05:10:35 INFO - mozrunner == 6.11 05:10:35 INFO - mozscreenshot == 0.1 05:10:35 INFO - mozsystemmonitor == 0.0 05:10:35 INFO - moztest == 0.7 05:10:35 INFO - mozversion == 1.4 05:10:35 INFO - psutil == 3.1.1 05:10:35 INFO - requests == 1.2.3 05:10:35 INFO - wsgiref == 0.1.2 05:10:35 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:35 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 0x7fb918377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test-pgo/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test-pgo/build/tests/talos 05:10:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 -r /builds/slave/test-pgo/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:10:35 INFO - Using env: {'DISPLAY': ':0', 05:10:35 INFO - 'HOME': '/home/cltbld', 05:10:35 INFO - 'LANG': 'en_US.UTF-8', 05:10:35 INFO - 'LANGUAGE': 'en_US:en', 05:10:35 INFO - 'LOGNAME': 'cltbld', 05:10:35 INFO - 'MAIL': '/var/mail/cltbld', 05:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:35 INFO - 'MOZ_NO_REMOTE': '1', 05:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:35 INFO - 'NO_EM_RESTART': '1', 05:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:35 INFO - 'SHELL': '/bin/bash', 05:10:35 INFO - 'SHLVL': '1', 05:10:35 INFO - 'TERM': 'linux', 05:10:35 INFO - 'TMOUT': '86400', 05:10:35 INFO - 'USER': 'cltbld', 05:10:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:35 INFO - '_': '/tools/buildbot/bin/python'} 05:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 2)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 3)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 5)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 6)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 7)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 8)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 9)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 1)) 05:10:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test-pgo/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:10:35 INFO - Cleaning up... 05:10:35 INFO - Return code: 0 05:10:35 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:35 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 0x7fb918377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:35 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test-pgo/build 05:10:35 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:10:35 INFO - Using env: {'DISPLAY': ':0', 05:10:35 INFO - 'HOME': '/home/cltbld', 05:10:35 INFO - 'LANG': 'en_US.UTF-8', 05:10:35 INFO - 'LANGUAGE': 'en_US:en', 05:10:35 INFO - 'LOGNAME': 'cltbld', 05:10:35 INFO - 'MAIL': '/var/mail/cltbld', 05:10:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:35 INFO - 'MOZ_NO_REMOTE': '1', 05:10:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:35 INFO - 'NO_EM_RESTART': '1', 05:10:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:35 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:35 INFO - 'SHELL': '/bin/bash', 05:10:35 INFO - 'SHLVL': '1', 05:10:35 INFO - 'TERM': 'linux', 05:10:35 INFO - 'TMOUT': '86400', 05:10:35 INFO - 'USER': 'cltbld', 05:10:35 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:35 INFO - '_': '/tools/buildbot/bin/python'} 05:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:35 INFO - Downloading/unpacking jsonschema 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:37 INFO - Downloading/unpacking functools32 (from jsonschema) 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10: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 05:10:37 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:37 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:38 INFO - warning: no files found matching '*.txt' 05:10:38 INFO - no previously-included directories found matching 'build' 05:10:38 INFO - no previously-included directories found matching 'dist' 05:10:38 INFO - no previously-included directories found matching '.git*' 05:10:38 INFO - Installing collected packages: jsonschema, functools32 05:10:38 INFO - Running setup.py install for functools32 05:10:38 INFO - warning: no files found matching '*.txt' 05:10:38 INFO - no previously-included directories found matching 'build' 05:10:38 INFO - no previously-included directories found matching 'dist' 05:10:38 INFO - no previously-included directories found matching '.git*' 05:10:38 INFO - Successfully installed jsonschema functools32 05:10:38 INFO - Cleaning up... 05:10:38 INFO - Return code: 0 05:10:38 INFO - Installing flake8 into virtualenv /builds/slave/test-pgo/build/venv 05:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:38 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 0x7fb918377f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17178a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17e6230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test-pgo', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:10:38 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test-pgo/build 05:10:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:10:38 INFO - Using env: {'DISPLAY': ':0', 05:10:38 INFO - 'HOME': '/home/cltbld', 05:10:38 INFO - 'LANG': 'en_US.UTF-8', 05:10:38 INFO - 'LANGUAGE': 'en_US:en', 05:10:38 INFO - 'LOGNAME': 'cltbld', 05:10:38 INFO - 'MAIL': '/var/mail/cltbld', 05:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:38 INFO - 'MOZ_NO_REMOTE': '1', 05:10:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:38 INFO - 'NO_EM_RESTART': '1', 05:10:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:38 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:38 INFO - 'SHELL': '/bin/bash', 05:10:38 INFO - 'SHLVL': '1', 05:10:38 INFO - 'TERM': 'linux', 05:10:38 INFO - 'TMOUT': '86400', 05:10:38 INFO - 'USER': 'cltbld', 05:10:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:38 INFO - '_': '/tools/buildbot/bin/python'} 05:10:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:38 INFO - Downloading/unpacking flake8 05:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:40 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:10:40 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:40 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:10:40 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:40 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:40 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:10:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:40 INFO - no previously-included directories found matching 'docs/_build' 05:10:40 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:10:41 INFO - Running setup.py install for pep8 05:10:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:41 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:41 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:41 INFO - no previously-included directories found matching 'docs/_build' 05:10:41 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:10:41 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:10:41 INFO - Cleaning up... 05:10:41 INFO - Return code: 0 05:10:41 INFO - Running post-action listener: _resource_record_post_action 05:10:41 INFO - Running post-action listener: _start_resource_monitoring 05:10:41 INFO - Starting resource monitoring. 05:10:41 INFO - ##### 05:10:41 INFO - ##### Running install step. 05:10:41 INFO - ##### 05:10:41 INFO - Running pre-action listener: _resource_record_pre_action 05:10:41 INFO - Running main action method: install 05:10:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:10:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:10:41 INFO - Reading from file tmpfile_stdout 05:10:41 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:10:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:10:41 INFO - Reading from file tmpfile_stdout 05:10:41 INFO - Output received: 05:10:41 INFO - Usage: mozinstall [options] installer 05:10:41 INFO - Options: 05:10:41 INFO - -h, --help show this help message and exit 05:10:41 INFO - -d DEST, --destination=DEST 05:10:41 INFO - Directory to install application into. [default: 05:10:41 INFO - "/builds/slave/test-pgo"] 05:10:41 INFO - --app=APP Application being installed. [default: firefox] 05:10:41 INFO - mkdir: /builds/slave/test-pgo/build/application 05:10:41 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test-pgo/build/application'] 05:10:41 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test-pgo/build/application 05:10:56 INFO - Reading from file tmpfile_stdout 05:10:56 INFO - Output received: 05:10:56 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:10:56 INFO - Running post-action listener: _resource_record_post_action 05:10:56 INFO - ##### 05:10:56 INFO - ##### Running run-tests step. 05:10:56 INFO - ##### 05:10:56 INFO - Running pre-action listener: _resource_record_pre_action 05:10:56 INFO - Running main action method: run_tests 05:10:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:10:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:10:56 INFO - Python 2.7.3 05:10:56 INFO - Return code: 0 05:10:56 INFO - grabbing minidump binary from tooltool 05:10:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:56 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 0x18787f0>, '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 0x17e42d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17e4760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:10:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test-pgo/build 05:10:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test-pgo/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:10:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:56 INFO - Return code: 0 05:10:56 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:10:56 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:10:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:10:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:10:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:10:56 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:10:56 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:10:57 INFO - Return code: 0 05:10:57 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test-pgo/build 05:10:57 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test-pgo/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log 05:10:57 INFO - Using env: {'DISPLAY': ':0', 05:10:57 INFO - 'HOME': '/home/cltbld', 05:10:57 INFO - 'LANG': 'en_US.UTF-8', 05:10:57 INFO - 'LANGUAGE': 'en_US:en', 05:10:57 INFO - 'LOGNAME': 'cltbld', 05:10:57 INFO - 'MAIL': '/var/mail/cltbld', 05:10:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:10:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:10:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:57 INFO - 'MOZ_NO_REMOTE': '1', 05:10:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:10:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:57 INFO - 'NO_EM_RESTART': '1', 05:10:57 INFO - 'PATH': '/builds/slave/test-pgo/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:57 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:57 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:10:57 INFO - 'SHELL': '/bin/bash', 05:10:57 INFO - 'SHLVL': '1', 05:10:57 INFO - 'TERM': 'linux', 05:10:57 INFO - 'TMOUT': '86400', 05:10:57 INFO - 'USER': 'cltbld', 05:10:57 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089', 05:10:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:57 INFO - '_': '/tools/buildbot/bin/python'} 05:10:57 INFO - Calling ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test-pgo/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 05:10:57 INFO - mozversion application_buildid: 20160225002727 05:10:57 INFO - mozversion application_changeset: b131aaab8f2f65db173486af71fe969c5ceff6da 05:10:57 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:10:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:57 INFO - mozversion application_name: Firefox 05:10:57 INFO - mozversion application_remotingname: firefox-dev 05:10:57 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:10:57 INFO - mozversion application_vendor: Mozilla 05:10:57 INFO - mozversion application_version: 46.0a2 05:10:57 INFO - mozversion platform_buildid: 20160225002727 05:10:57 INFO - mozversion platform_changeset: b131aaab8f2f65db173486af71fe969c5ceff6da 05:10:57 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:10:57 INFO - mozversion platform_version: 46.0a2 05:10:57 INFO - using testdate: 1456578657 05:10:57 INFO - actual date: 1456578657 05:10:57 INFO - starting webserver on 'localhost:45416' 05:10:57 INFO - SUITE-START | Running 3 tests 05:10:57 INFO - TEST-START | dromaeo_css 05:10:57 INFO - operating with platform_type : linux_ 05:10:57 INFO - Initialising browser for dromaeo_css test... 05:10:57 INFO - TEST-INFO | started process 15960 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphr8oV7/profile http://localhost:45416/getInfo.html) 05:11:01 INFO - PROCESS | 15960 | 05:11:01 INFO - PROCESS | 15960 | (process:16036): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:11:02 INFO - PROCESS | 15960 | __metrics Screen width/height:1600/1200 05:11:02 INFO - PROCESS | 15960 | colorDepth:24 05:11:02 INFO - PROCESS | 15960 | Browser inner width/height: 1024/697 05:11:02 INFO - PROCESS | 15960 | __metrics 05:11:02 INFO - TEST-INFO | 15960: exit 0 05:11:02 INFO - Browser initialized. 05:11:02 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:02 INFO - TEST-INFO | started process 16085 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmphr8oV7/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:04 INFO - PROCESS | 16085 | 05:11:04 INFO - PROCESS | 16085 | (process:16145): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:11:14 INFO - PROCESS | 16085 | RSS: Main: 140505088 05:11:14 INFO - PROCESS | 16085 | 05:12:04 INFO - PROCESS | 16085 | 1456578724433 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:14:12 INFO - PROCESS | 16085 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45416/tests/dromaeo/cssquery-ext.html) 05:14:13 INFO - PROCESS | 16085 | RSS: Main: 146231296 05:14:13 INFO - PROCESS | 16085 | 05:17:15 INFO - PROCESS | 16085 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-ext.html (next: http://localhost:45416/tests/dromaeo/cssquery-jquery.html) 05:17:15 INFO - PROCESS | 16085 | RSS: Main: 144314368 05:17:15 INFO - PROCESS | 16085 | 05:20:17 INFO - PROCESS | 16085 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45416/tests/dromaeo/cssquery-mootools.html) 05:20:17 INFO - PROCESS | 16085 | RSS: Main: 141832192 05:20:17 INFO - PROCESS | 16085 | 05:23:19 INFO - PROCESS | 16085 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45416/tests/dromaeo/cssquery-prototype.html) 05:23:20 INFO - PROCESS | 16085 | RSS: Main: 143126528 05:23:20 INFO - PROCESS | 16085 | 05:26:22 INFO - PROCESS | 16085 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45416/tests/dromaeo/cssquery-yui.html) 05:26:22 INFO - PROCESS | 16085 | RSS: Main: 144617472 05:26:22 INFO - PROCESS | 16085 | 05:29:25 INFO - PROCESS | 16085 | Cycle 1(1): loaded http://localhost:45416/tests/dromaeo/cssquery-yui.html (next: http://localhost:45416/tests/dromaeo/cssquery-dojo.html) 05:29:25 INFO - PROCESS | 16085 | RSS: Main: 145993728 05:29:25 INFO - PROCESS | 16085 | 05:29:25 INFO - PROCESS | 16085 | __start_tp_report 05:29:25 INFO - PROCESS | 16085 | _x_x_mozilla_page_load 05:29:25 INFO - PROCESS | 16085 | _x_x_mozilla_page_load_details 05:29:25 INFO - PROCESS | 16085 | |i|pagename|runs| 05:29:25 INFO - PROCESS | 16085 | |0;dojo.html;3284.8193349365793;3364.966350336496;3373.2578832656823;3411.7952922824634;3413.1978984938537;5456.61803673743;5504.394516603175;5525.557955363572;5525.696086715229;5545.584081193916;5469.343678758554;5544.417836127209;5555.027870122733;5557.194206840016;5563.221149039127;4947.628927830409;5046.596272298208;5119.795208191668;5119.920219396659;5175.508326708957;4814.9037019259595;4964.329815474901;4992.550670439659;5004.949950500485;5070.442251352349;5008.649394542384;5053.570446512051;5057.873553161164;5068.594512439015;5072.26452164436;5026.120428924942;5036;5048.444671086178;5068.898622027557;5071;4811.4707382187935;4851.684640498356;4900.995295964354;4937.851864444036;4961.08219979305;5138.049460849755;5173.456787037345;5181.248718935771;5216.921746173811;5242.7378631068295;5811.27359080115;5827.766889324422;5845.503132233765;5850.882982340372;5874.853128671774;5701.116326969326;5779.479846813807;5817.476427121537;5882.823515294548;5981.282246130449;5466.988607107698;5472.835814925558;5483.588730845203;5508.788066625376;5531.889362212773;5990.221271234712;5994.610350327215;6003.8198854034445;6004.42957918997;6005.669688167105;5586.162075688598;5617.831465055973;5636.746346414421;5732.111522713986;5739.713014349266;5825.970870145707;5828.795992140254;5832.737526811219;5835.883282334329;5876.676782776988;5690.573207009408;5783.421657834183;5811.3316968548315;5814.767409303665;5816.127580862904;5759.164921086419;5798.304203495608;5826.970865145732;5901.203337549462;5928.199693041384;4477.261251893467;4492.618127459137;4494.37078808967;4505.121501307213;4509.706869053567;3975.0658595230097;3990.06233535119;4065.7560546367313;4074.022234663659;4087.346024636044;5417.295751552273;5483.862903427366;5502.807401741;5516.862078447991;5543.6396634218645;5735.627184233012;5821.563382746311;5831.067029275296;5885.823425297248;5901.76392944286;5426.9185962210595;5454.7818087276855;5538;5555.055640541118;5555.3611334697025;5102.617303702237;5116.513931176532;5118.846434606968;5120.334356533627;5125.2568377585785;6043.335233124353;6051.576389652682;6076.696165191811;6101.725422356005;6110.694465276719;5778.8844223114465;5838.708064596668;5853.356130825691;5890.793822216202;5955.017422125301;5947.197128387786;5974.910376344272;5980.910286345621;6010.278766548042;6037.215162028908;5744.0522313817755;5764.654120752768;5769.826905192851;5780.248567686174;5807.332156801853;5733;5735.11105778605;5873.706314684163;5932.851678708067;6007.249093863267;5687.203791469115;5690.3456102548735;5690.459406356389;5716.371199168171;5719.3136823581435;5599.216109744558;5682.602217844877;5685.715714214355;5703.62926409782;5713.571482138773;5514.641548299348;5625.043742563692;5674.886502270014;5683.005474042109;5718.714064296852;5722.799702010409;5732.455416735404;5754.877798829188;5777.335606405317;5804.390538993345;5489.313835770528;5550.4449555044175;5638.295213098363;5649.096144617006;5670.291213598301 05:29:25 INFO - PROCESS | 16085 | |1;ext.html;543.6982474726527;554.2157846646995;558.7122631844599;585.3414908228243;621.4748537485824;33118.33763324732;37315.44026839596;37442;37483.4377484338;37598.24803503928;39827.40258896119;40283.79858100705;40324.59675403245;40663;40710.79644601773;8750.737477875658;8964.417312874675;9006.099390061006;9027.95486022569;9037.683681071163;8711.34664900135;8755.124487551258;8809.471431714086;8832.381733278673;9026.413283136575;9043.186113249807;9043.457392556467;9052.140046695586;9152.633894644207;9196.724098277062;8934.821303573925;9038.18656320931;9050.728478145666;9069.863952040758;9085.954570227173;8918.464892106429;8960.820783584291;8965.641374345018;8968.820623587557;9007.549622518847;41232.79383603063;41444.1711165778;41799.37300940488;41850.37224441636;41915.58084419147;3490.7905525668543;3551.200979779555;3644.234710710754;3825.196708691178;4097.590240975908;31149.532757008663;31402;31616.36767264642;31890.043298700843;31893.362132757447;4147.958520414787;4250.277452832995;4292.0772034012525;4303.720258183208;4307.569243075699;274088;275416;275625;275874;276576.99999999796;42933.35599966003;43433.56566434359;43661;43746;43782.781086094365;40483;40745;41011.179776404904;41077.79461102675;41124;16166.595835104217;16334.918325408535;16387.67224655524;16415.343386264656;16561.6687666246;12194.756104877853;12435.75128497425;12447.128700990843;12460.626181214579;12818.166819156724;14953;14977.176255305845;15059.322330495153;15060.54818355451;15077.246137693071;6017.638941663514;6131.816045518642;6151;6214.37856214384;6282.340354262828;1002.7015015554874;1022.6420752736632;1080.5839751695496;1135.3471753741633;1141.6289705845634;29959;30021.849890750407;30045.549316760265;30447.847760761055;30998.380032399225;1124.0670243697712;1127.3855748617023;1140.788954043488;1205.5177928828364;1254.7678679444332;15660.92169539145;15840.44558440449;15894.841051589567;16108.436204732778;16225.837741622669;318107;740868;742733;749146;749838;57417.42582574121;57617;57663.13505297424;58022.7098864503;58469.41530584725;1461.6492041910078;1495.0431723696624;1498.5054931872455;1508.2232650185163;1515.3484001879299;30666;30697.693023069485;30751;31291.374172516877;31762.682373175972;48170.759146204044;48295;48557.514424856716;48604;48787.756061219465;291707;291711;291779;292283;293431;32651.836740816143;33606.49590256197;33624;33756.66243337535;33921.15197119993;40310.798446008754;44109;44670.55329446664;44913.10173796571;44950.55049449595;37480;37755.62244377521;37767.62232377751;38548.229035419696;38637;37282.627173729;37737.97645180559;37885.62114378821;37991.43012854864;38365.80817095897;37009.44485832768;37608.43587346137;37925.24149517049;38036.42945355766;38132.23735525218;33488.16279593029;33564.832175838965;33569;33890;33944;26048.8697556511;26458.86770566135;26578.7342126584;26634.334141646614;26956.595651064858 05:29:25 INFO - PROCESS | 16085 | |2;jquery.html;388.68516501633695;390.4865102390356;392.5387669488351;394.16437153235137;402.6034356159181;15542.067475951451;16372.672546549062;17084.060376679277;17818;17861.553461163476;10664.093552048085;11088.501017454213;11187.776244475106;14426.783598246035;17552.0346380949;4980.626453016029;5014.2979982802435;5127.435982041991;5186.092433824085;5188.247704082905;5063.594912407017;5313.256144139824;5454.372747134091;5491.313585801775;5497.257870187534;5419.674819510822;5448.809291674792;5484.780608775644;5492.340919089715;5618.522425593829;5579.972100139494;5592.3009623797025;5606.887862242773;5608.214849921014;5636.464535869086;5336.252924590561;5429.619926605139;5507.586930980153;5521.033819081645;5600.831975040755;12551.874481255161;12712.809307860389;17080.57298567546;21586.460338491663;21610.89194554033;2209.0942713487393;2249.3701763506247;2257.390504563775;2333.94165145871;2349.7180338359335;9438.622455101857;9476;9482.099200575934;9718.757031074208;13167.934160329232;1874.5126267170497;1886.9716954245698;1898.905054747257;1946.7177259297323;1966.8819870807654;57945;57957;59330.40669593292;59888.70055649737;60223;10846.18653600983;10865.891341086488;10900.236983411243;10927.453627318602;10999.450027498593;14324.856751432353;14329.211893345966;14345.139291642536;14360.138391696531;14384.712305754036;7493.625318734042;7583.658735356922;7766.068071831416;7788.415868809862;7826.3347615452185;7376.188619251878;7379.483436159418;7382.778516644509;7410.592417417094;7444.255574442513;4295.205387003414;4747.881302967454;4752.239641657387;4780.880477988078;4800.231962885921;1876.3714155757973;1904.6762050451457;2011.5876245369664;2022.7067075274297;2032.1160295271309;939.4269495607674;993.5777294649889;1066.671993368246;1084.3819023156725;1101.168617693652;16155.192240387934;16662.916685416494;16691.749623755655;17061.48815535536;17292.04893730857;1026.779242462874;1048.2871647279924;1057.7302787789217;1073.2969904712427;1092.639428988432;9563.856542151872;9999.200063994864;10572.788544229226;10625.5218515167;10653.78692426147;513144;514250;517634;517880.97344469;523950;73682;75314;75474.6226268876;75510.24489755143;76762.6161869187;1192.9403529823473;1198.1493139870615;1215.8905698487001;1224.4367590908105;1227.6808029912288;16167.514974550782;16193.95609332394;16253.918730406273;16349.918250408671;16566.088865112535;31758.841205793822;34152.14619634529;35061.649383505835;35116.82441587776;35498;37271.62728372682;46542;46830;49494.75252623714;52055.47944520506;10099.29304948676;10545.261831672016;11088.611898583511;11285.661430157108;11403.144764142557;8069.7175598853755;8743.693970710994;9014.368994170345;12423.875761242272;12929;8016.318612917968;8296.585170741559;8342.207490288412;8394.664213431395;8402.621882015203;7962.402819788424;8191.754247372588;8331.625076871434;8486.448380855225;8499.702510412106;8109.189081091844;8298.585070746318;8486.108958559262;8509.106543813057;8528.403011789114;10543.31468454548;10700.839487407851;10858.511366988663;10892.346459212473;11011.064059555027;11033.22767406306;11217.102631789274;11422.600208992646;11487.425628718363;11499.08007359426 05:29:25 INFO - PROCESS | 16085 | |3;mootools.html;1454.3310077364413;1480.8000919875813;1664.5422508810075;1807.3854889337622;1850.3986204483547;7841.882371764428;7942.801429964254;8055.26811735476;8056;8115.431919765619;8058.677652893877;8063.31461825744;8185.672573097084;8199.303059239957;8207.753767386974;2390.043982407042;2416.178499310234;2435.610302351624;2437.9756202438016;2444.010175878772;2405.6271277951946;2441.6703744994375;2445.9143929962456;2448.2532827487607;2453.6319552067152;2358.398608354867;2405.458771776354;2406.2300063979533;2428.7206971198275;2431.781139697427;2437.731849496554;2445.303088619744;2465.778079972793;2470.419451428913;2475.4553998120386;2423.297243799296;2430.829841911067;2435.281591930385;2442.6091825307867;2455.373879660693;7956.562389068599;7977.042754869452;8018.839623207561;8019;8047.597620119029;4903.092927808367;5030.270610761456;5030.924536131961;5109.897802043975;5114.488551144856;3227.6288226853976;3229.160418291238;3241.8054916705073;3246.3994161080277;3348.5312056312137;1049.685094471663;1064.1433645915035;1092.595739576362;1103.1450625765017;1123.6516679829197;11102.111831053497;11121.777564448666;11163.665090047312;11195.440227988567;11201.159913006557;4316.201502722007;4345.500267469281;4375.584319489643;4431.623312018514;4444.11117776446;9058.909410905806;9062.410943288665;9067.365284430027;9085.091490850862;9088.81822363549;4935.506449355035;4963.851084467472;5005.5745261653165;5023.547880690682;5041.369828771403;4597.609203217697;4617.6536759742485;4670.626349892001;4673.345731597579;4698.107359601733;3640.8361623726996;3650.7261955353456;3695.7597756145765;3696.963030369716;3712.7586706863967;1107.0921844087932;1112.7718817642526;1121.8429419881222;1129.768397478515;1179.0744265751516;1049.8792638846478;1084.4252546150553;1087.7063192938022;1286.9935650321688;1379.2827729580563;7456.067991501062;7481.812954676177;7524.548527088283;7552.471327007057;7604.2395760423515;1167.258790667915;1181.8640856301463;1199.1665792274287;1200.591798788416;1211.8909298163207;5908.261467316585;6016.037434010625;6078.331383547807;6080.878382432326;6122.326544080237;9417.48203848795;9994.200463962865;10012;10072.949635251924;10147.34042287249;9781.510924453749;9875.111239988435;9881.950590247146;9926.851097233548;10024.899751002542;7602.885956710654;7705.57619330931;7751.844963100819;7820.7653770388115;7839.9216007839195;7569.772906812805;7614.961925190339;7643.350315223268;7646.579438130733;7700.306972372289;8587.141285871363;8739.475631462132;8789.296856251613;8854.601542930455;8860.689875854314;8873.423227490193;8959.238464730572;9005;9116.498592577473;9165.404248723811;7408;7559.773206803805;7568.659410326439;7578.09062912454;7578.886316705364;7708.653110610148;7713.074431068308;7733.265339792711;7978.361731061617;8034.437589368688;6678.065070889982;7588.317051465395;7646.120696120018;7646.847063058819;7694.192109828611;6846.726130954706;6858.4856135791015;6921.757738479129;6969.407600354027;7044.577325360495;6958.408535274559;7074.858502829811;7087.68105435267;7095.184053833668;7101.786946391617;6555.541112122296;6559.967200163968;6572.901406478811;6590.50571207171;6623.437007854386;6666.600003999775;6671.733130674718;6708.161479815023;6750.729970801113;6752.155980502437 05:29:25 INFO - PROCESS | 16085 | |4;prototype.html;356.5721134638434;364.94708267301223;365.444524323029;366.9908252293694;369.4421423650289;6283.120363149163;6371.108044873716;6393.584417012897;6414.583052101621;6464.482841372691;6205.22434695663;6333.113364129025;6350.904736428957;6394.040893865911;6399.712012959416;4847.878803029935;4869.318295438641;4886.096072226632;4893.290472881439;4894.412670479547;4886.071646387193;4890.315355850184;4892.217245240762;4902.828401005965;4905.705657660552;4719.669623126365;4857.417109946811;4858;4862.319275301461;4862.659613827033;4812.759362031885;4819.228923372244;4829.637777166709;4848.903021939542;4852.126617208936;4236.004538933348;4236.936445953283;4237.915241695179;4240.194363071007;4254.212970600418;6025.969870150665;6098.420650038283;6104.542159338023;6123.418275263843;6149.446549810494;5651.06757385031;5661.631993920423;5668.404817494145;5679.864027194536;5681.375048744635;6746.190457145174;6746.561473504206;6749.19009718832;6752.864942701168;6753.45972322213;4688.2733176357715;4708.152532544175;4712.9057418851435;4723.4331880174595;4751.3585665935;6922.58464492132;7016.228214896358;7064.752733654349;7095.609741464217;7115.75094871677;4791.377120974321;4808.182608956486;4821.252705830602;4822.590079843252;4830.058138662997;4889.168841296988;4893.804247830047;4895.485973972753;4895.730734809548;4900.215965445583;5497.9828731684765;5653.180288858092;5663.830085097454;5671.234383358276;5673.432656734376;6810.761623343159;6837.521373503807;6838.247792742794;6865.656717164122;6868.484863635247;1691.4249155287016;1717.957051073708;1730.7144321187116;1731.039273203359;1738.9217485213196;1151.1596534529672;1163.3485248261002;1171.1509155862102;1183.9171258011856;1187.2935603316014;6494.4479719223455;6523.739050438025;6529.510286728514;6568.704408301638;6580.177477815273;6956;6962.965185174143;7013.6142512161305;7031.191412987469;7036.6129862857015;6453.935460645427;6535.8692826143215;6552.967235163794;6556.672166391661;6578.769743059066;3779.5464544254864;3795.1081495848453;3801.258754542893;3805.752626079296;3813.9809300953316;7258.455615828834;7265.128184617774;7267.563946163247;7268.927310726931;7280.235575264521;7002.649867506604;7160.928390716026;7166.211716711157;7180.712771489187;7196.532225405332;7130.215676275606;7199.920011998242;7225.819354516179;7231.529950553302;7251.1661158966335;6945.617991010543;6951.27011663768;6976.337247961435;6989.440844732308;7009.264027277062;6790.151231096113;6876.553024053421;6881.552699074544;7009.264027277062;7039.260877607778;7323.377512911249;7376.7786966391095;7384.556926584422;7385.446091543048;7391.0761154855645;4832.565069143653;4872.561469467765;4879.999600082046;4880.95119048805;4902.975485122552;6988.126484189476;7035.47233957445;7077.752278670222;7094.609796461038;7170.1754298256365;6908.896366554405;6930.861382772216;6969.059177011241;6972.442204623517;7018.6490675465;6905.551139175937;6916.619585922823;6952.513324067267;6959.686814093479;6962.547434416747;6685.431738302299;6801.319868013159;6806.523543351917;6820.693068812015;6825.931740682529;6941.965290173517;6953.443724501926;6981.650917454005;6996.965015174892;6997.825054373681;6756.087928129836;6767.424768894502;6797.150356205474;6806.2513123557355;6811.2631279023535 05:29:25 INFO - PROCESS | 16085 | |5;yui.html;785.308928143234;791.9960400197998;876.2726936642588;921.7649499377662;934.5841100710187;14696.926515367435;14733.410663573444;14746.557603271893;14805.55583332499;14836.184009879453;13442.798358024638;13955.092918960261;14018.719625607482;14051.367688454018;14065.859341406584;826.5288785392329;835.2858306148247;840.4705035827451;847.3136759225048;847.3475423923575;852.3309202276214;854.2269246332079;855.0380821575727;860.1527495417009;860.3375400941303;891.9152680495342;892.1435421994893;893.6023469556051;893.9240164585985;898.1826537850558;879.4195830751673;889.1153302464057;889.208604342136;889.4263200235877;889.4618755652801;654.9181352330959;655.8589903170841;656.9474442044625;657.4510283912938;661.381608196338;15291.235438228045;15322.23388830554;15450.9227453862;15457.381704731797;15468.767968480483;13328.666783330495;13420.5302814402;13679.931600342034;13732.176069435765;13799.448022079105;11465.54137834494;11550.191486595857;11716.121290903217;12014.63956081319;12083.637490875288;3878.6897048236074;3886.844526218976;3896.7467114637457;3907.199024200032;4050.1494686115657;47945.52054479445;47999;48153;48576.75711621455;49131;10032.598696052222;10282.177425805918;10369;10372.325798823053;10444.843327350096;18289.90855045743;18442.815571844378;18862.62274754497;18875.244990200237;18946.052697365078;7943.920560794434;8069.314108300743;8076.27313541784;8117.310028647631;8319.916800832036;4640.234361330343;4782.426108866958;4791.401074865642;4808.35087263222;4818.638602104786;3067.0492147434366;3103.736182424474;3107.5494053362136;3124.5781819454537;3125.8437078146003;564.5483613109496;586.8415527807554;590.0352922970974;592.7303077099996;606.5238787551839;589.8820235952827;754.5208792416855;759.2445516710798;770.9306162445407;780.3172224303735;9283.767905802273;9290.814183716422;9382.48396338208;9409.529523523797;9421.340506164639;629.8393909553126;669.7823207457595;745.1765798792364;757;766.8312971146339;4246.808893599796;4320.222359975234;4358.128374325148;4491.842785502492;4772.188727916263;51076.74461627668;53959.73020134874;54163.72918135463;54246.45753542493;54386.184207236925;51372.22941655878;51397.74301128545;51654.741726291126;52468.475315247124;52950.73524632352;46816.7659161702;47144.29283560749;47178.29232561514;48750.756246218545;48871.511284887405;9516.857247141437;9559.900611429775;9615.951920240634;9657.661981830603;9837.803243934937;36255.27489450249;37050.814745926094;37111.814440928705;37633.62366376301;38683.80658096691;47038;47224.2916356248;47440.76279618718;47764.7611761939;47961.5203847971;12081.275123492618;12087.153899226969;12205.084618653458;12428.62714118578;12623.179493332904;13307.909070089594;13380;13472.663183420102;13918.721625567634;13971.860281397463;12741.55404560836;12744.299063551594;12950.481980720666;12996.220226786423;13157.407916643582;12436.067294952734;12595.874041259836;12913.806292905427;12948.417321220757;13275.66810829737;12419.503219871103;12682.365881706062;12820.358982050673;13105.606831795061;13197.538086166938;10540.578376865145;10563.52464139131;10797.946010269898;10966.561337546409;11057.557697692002;10592.258541901992;10836.783264334512;10889.618863339745;10895.182861285593;10942.781144376908 05:29:25 INFO - PROCESS | 16085 | __end_tp_report 05:29:25 INFO - PROCESS | 16085 | __start_cc_report 05:29:25 INFO - PROCESS | 16085 | _x_x_mozilla_cycle_collect,292 05:29:25 INFO - PROCESS | 16085 | __end_cc_report 05:29:25 INFO - PROCESS | 16085 | __startTimestamp1456579765334__endTimestamp 05:29:25 INFO - PROCESS | 16085 | 05:29:25 INFO - PROCESS | 16085 | ------- Summary: start ------- 05:29:25 INFO - PROCESS | 16085 | Number of tests: 6 05:29:25 INFO - PROCESS | 16085 | 05:29:25 INFO - PROCESS | 16085 | [#0] dojo.html Cycles:165 Average:5435.61 Median:5636.75 stddev:581.92 (10.3%) stddev-sans-first:558.71 05:29:25 INFO - PROCESS | 16085 | Values: 3284.8 3365.0 3373.3 3411.8 3413.2 5456.6 5504.4 5525.6 5525.7 5545.6 5469.3 5544.4 5555.0 5557.2 5563.2 4947.6 5046.6 5119.8 5119.9 5175.5 4814.9 4964.3 4992.6 5004.9 5070.4 5008.6 5053.6 5057.9 5068.6 5072.3 5026.1 5036.0 5048.4 5068.9 5071.0 4811.5 4851.7 4901.0 4937.9 4961.1 5138.0 5173.5 5181.2 5216.9 5242.7 5811.3 5827.8 5845.5 5850.9 5874.9 5701.1 5779.5 5817.5 5882.8 5981.3 5467.0 5472.8 5483.6 5508.8 5531.9 5990.2 5994.6 6003.8 6004.4 6005.7 5586.2 5617.8 5636.7 5732.1 5739.7 5826.0 5828.8 5832.7 5835.9 5876.7 5690.6 5783.4 5811.3 5814.8 5816.1 5759.2 5798.3 5827.0 5901.2 5928.2 4477.3 4492.6 4494.4 4505.1 4509.7 3975.1 3990.1 4065.8 4074.0 4087.3 5417.3 5483.9 5502.8 5516.9 5543.6 5735.6 5821.6 5831.1 5885.8 5901.8 5426.9 5454.8 5538.0 5555.1 5555.4 5102.6 5116.5 5118.8 5120.3 5125.3 6043.3 6051.6 6076.7 6101.7 6110.7 5778.9 5838.7 5853.4 5890.8 5955.0 5947.2 5974.9 5980.9 6010.3 6037.2 5744.1 5764.7 5769.8 5780.2 5807.3 5733.0 5735.1 5873.7 5932.9 6007.2 5687.2 5690.3 5690.5 5716.4 5719.3 5599.2 5682.6 5685.7 5703.6 5713.6 5514.6 5625.0 5674.9 5683.0 5718.7 5722.8 5732.5 5754.9 5777.3 5804.4 5489.3 5550.4 5638.3 5649.1 5670.3 05:29:25 INFO - PROCESS | 16085 | 05:29:25 INFO - PROCESS | 16085 | [#1] ext.html Cycles:180 Average:55677.64 Median:37826.62 stddev:123059.01 (325.3%) stddev-sans-first:123334.60 05:29:25 INFO - PROCESS | 16085 | Values: 543.7 554.2 558.7 585.3 621.5 33118.3 37315.4 37442.0 37483.4 37598.2 39827.4 40283.8 40324.6 40663.0 40710.8 8750.7 8964.4 9006.1 9028.0 9037.7 8711.3 8755.1 8809.5 8832.4 9026.4 9043.2 9043.5 9052.1 9152.6 9196.7 8934.8 9038.2 9050.7 9069.9 9086.0 8918.5 8960.8 8965.6 8968.8 9007.5 41232.8 41444.2 41799.4 41850.4 41915.6 3490.8 3551.2 3644.2 3825.2 4097.6 31149.5 31402.0 31616.4 31890.0 31893.4 4148.0 4250.3 4292.1 4303.7 4307.6 274088.0 275416.0 275625.0 275874.0 276577.0 42933.4 43433.6 43661.0 43746.0 43782.8 40483.0 40745.0 41011.2 41077.8 41124.0 16166.6 16334.9 16387.7 16415.3 16561.7 12194.8 12435.8 12447.1 12460.6 12818.2 14953.0 14977.2 15059.3 15060.5 15077.2 6017.6 6131.8 6151.0 6214.4 6282.3 1002.7 1022.6 1080.6 1135.3 1141.6 29959.0 30021.8 30045.5 30447.8 30998.4 1124.1 1127.4 1140.8 1205.5 1254.8 15660.9 15840.4 15894.8 16108.4 16225.8 318107.0 740868.0 742733.0 749146.0 749838.0 57417.4 57617.0 57663.1 58022.7 58469.4 1461.6 1495.0 1498.5 1508.2 1515.3 30666.0 30697.7 30751.0 31291.4 31762.7 48170.8 48295.0 48557.5 48604.0 48787.8 291707.0 291711.0 291779.0 292283.0 293431.0 32651.8 33606.5 33624.0 33756.7 33921.2 40310.8 44109.0 44670.6 44913.1 44950.6 37480.0 37755.6 37767.6 38548.2 38637.0 37282.6 37738.0 37885.6 37991.4 38365.8 37009.4 37608.4 37925.2 38036.4 38132.2 33488.2 33564.8 33569.0 33890.0 33944.0 26048.9 26458.9 26578.7 26634.3 26956.6 05:29:25 INFO - PROCESS | 16085 | 05:29:25 INFO - PROCESS | 16085 | [#2] jquery.html Cycles:180 Average:27315.16 Median:389.59 stddev:84594.68 (21714.0%) stddev-sans-first:84807.83 05:29:25 INFO - PROCESS | 16085 | Values: 388.7 390.5 392.5 394.2 402.6 15542.1 16372.7 17084.1 17818.0 17861.6 10664.1 11088.5 11187.8 14426.8 17552.0 4980.6 5014.3 5127.4 5186.1 5188.2 5063.6 5313.3 5454.4 5491.3 5497.3 5419.7 5448.8 5484.8 5492.3 5618.5 5580.0 5592.3 5606.9 5608.2 5636.5 5336.3 5429.6 5507.6 5521.0 5600.8 12551.9 12712.8 17080.6 21586.5 21610.9 2209.1 2249.4 2257.4 2333.9 2349.7 9438.6 9476.0 9482.1 9718.8 13167.9 1874.5 1887.0 1898.9 1946.7 1966.9 57945.0 57957.0 59330.4 59888.7 60223.0 10846.2 10865.9 10900.2 10927.5 10999.5 14324.9 14329.2 14345.1 14360.1 14384.7 7493.6 7583.7 7766.1 7788.4 7826.3 7376.2 7379.5 7382.8 7410.6 7444.3 4295.2 4747.9 4752.2 4780.9 4800.2 1876.4 1904.7 2011.6 2022.7 2032.1 939.4 993.6 1066.7 1084.4 1101.2 16155.2 16662.9 16691.7 17061.5 17292.0 1026.8 1048.3 1057.7 1073.3 1092.6 9563.9 9999.2 10572.8 10625.5 10653.8 513144.0 514250.0 517634.0 517881.0 523950.0 73682.0 75314.0 75474.6 75510.2 76762.6 1192.9 1198.1 1215.9 1224.4 1227.7 16167.5 16194.0 16253.9 16349.9 16566.1 31758.8 34152.1 35061.6 35116.8 35498.0 37271.6 46542.0 46830.0 49494.8 52055.5 10099.3 10545.3 11088.6 11285.7 11403.1 8069.7 8743.7 9014.4 12423.9 12929.0 8016.3 8296.6 8342.2 8394.7 8402.6 7962.4 8191.8 8331.6 8486.4 8499.7 8109.2 8298.6 8486.1 8509.1 8528.4 10543.3 10700.8 10858.5 10892.3 11011.1 11033.2 11217.1 11422.6 11487.4 11499.1 05:29:25 INFO - PROCESS | 16085 | 05:29:25 INFO - PROCESS | 16085 | [#3] mootools.html Cycles:180 Average:5707.03 Median:6047.18 stddev:2933.57 (48.5%) stddev-sans-first:2924.38 05:29:25 INFO - PROCESS | 16085 | Values: 1454.3 1480.8 1664.5 1807.4 1850.4 7841.9 7942.8 8055.3 8056.0 8115.4 8058.7 8063.3 8185.7 8199.3 8207.8 2390.0 2416.2 2435.6 2438.0 2444.0 2405.6 2441.7 2445.9 2448.3 2453.6 2358.4 2405.5 2406.2 2428.7 2431.8 2437.7 2445.3 2465.8 2470.4 2475.5 2423.3 2430.8 2435.3 2442.6 2455.4 7956.6 7977.0 8018.8 8019.0 8047.6 4903.1 5030.3 5030.9 5109.9 5114.5 3227.6 3229.2 3241.8 3246.4 3348.5 1049.7 1064.1 1092.6 1103.1 1123.7 11102.1 11121.8 11163.7 11195.4 11201.2 4316.2 4345.5 4375.6 4431.6 4444.1 9058.9 9062.4 9067.4 9085.1 9088.8 4935.5 4963.9 5005.6 5023.5 5041.4 4597.6 4617.7 4670.6 4673.3 4698.1 3640.8 3650.7 3695.8 3697.0 3712.8 1107.1 1112.8 1121.8 1129.8 1179.1 1049.9 1084.4 1087.7 1287.0 1379.3 7456.1 7481.8 7524.5 7552.5 7604.2 1167.3 1181.9 1199.2 1200.6 1211.9 5908.3 6016.0 6078.3 6080.9 6122.3 9417.5 9994.2 10012.0 10072.9 10147.3 9781.5 9875.1 9882.0 9926.9 10024.9 7602.9 7705.6 7751.8 7820.8 7839.9 7569.8 7615.0 7643.4 7646.6 7700.3 8587.1 8739.5 8789.3 8854.6 8860.7 8873.4 8959.2 9005.0 9116.5 9165.4 7408.0 7559.8 7568.7 7578.1 7578.9 7708.7 7713.1 7733.3 7978.4 8034.4 6678.1 7588.3 7646.1 7646.8 7694.2 6846.7 6858.5 6921.8 6969.4 7044.6 6958.4 7074.9 7087.7 7095.2 7101.8 6555.5 6560.0 6572.9 6590.5 6623.4 6666.6 6671.7 6708.2 6750.7 6752.2 05:29:25 INFO - PROCESS | 16085 | 05:29:25 INFO - PROCESS | 16085 | [#4] prototype.html Cycles:180 Average:5702.14 Median:6479.47 stddev:1725.35 (26.6%) stddev-sans-first:1682.89 05:29:25 INFO - PROCESS | 16085 | Values: 356.6 364.9 365.4 367.0 369.4 6283.1 6371.1 6393.6 6414.6 6464.5 6205.2 6333.1 6350.9 6394.0 6399.7 4847.9 4869.3 4886.1 4893.3 4894.4 4886.1 4890.3 4892.2 4902.8 4905.7 4719.7 4857.4 4858.0 4862.3 4862.7 4812.8 4819.2 4829.6 4848.9 4852.1 4236.0 4236.9 4237.9 4240.2 4254.2 6026.0 6098.4 6104.5 6123.4 6149.4 5651.1 5661.6 5668.4 5679.9 5681.4 6746.2 6746.6 6749.2 6752.9 6753.5 4688.3 4708.2 4712.9 4723.4 4751.4 6922.6 7016.2 7064.8 7095.6 7115.8 4791.4 4808.2 4821.3 4822.6 4830.1 4889.2 4893.8 4895.5 4895.7 4900.2 5498.0 5653.2 5663.8 5671.2 5673.4 6810.8 6837.5 6838.2 6865.7 6868.5 1691.4 1718.0 1730.7 1731.0 1738.9 1151.2 1163.3 1171.2 1183.9 1187.3 6494.4 6523.7 6529.5 6568.7 6580.2 6956.0 6963.0 7013.6 7031.2 7036.6 6453.9 6535.9 6553.0 6556.7 6578.8 3779.5 3795.1 3801.3 3805.8 3814.0 7258.5 7265.1 7267.6 7268.9 7280.2 7002.6 7160.9 7166.2 7180.7 7196.5 7130.2 7199.9 7225.8 7231.5 7251.2 6945.6 6951.3 6976.3 6989.4 7009.3 6790.2 6876.6 6881.6 7009.3 7039.3 7323.4 7376.8 7384.6 7385.4 7391.1 4832.6 4872.6 4880.0 4881.0 4903.0 6988.1 7035.5 7077.8 7094.6 7170.2 6908.9 6930.9 6969.1 6972.4 7018.6 6905.6 6916.6 6952.5 6959.7 6962.5 6685.4 6801.3 6806.5 6820.7 6825.9 6942.0 6953.4 6981.7 6997.0 6997.8 6756.1 6767.4 6797.2 6806.3 6811.3 05:29:25 INFO - PROCESS | 16085 | 05:29:25 INFO - PROCESS | 16085 | [#5] yui.html Cycles:180 Average:14482.40 Median:46927.38 stddev:15947.78 (34.0%) stddev-sans-first:15959.35 05:29:25 INFO - PROCESS | 16085 | Values: 785.3 792.0 876.3 921.8 934.6 14696.9 14733.4 14746.6 14805.6 14836.2 13442.8 13955.1 14018.7 14051.4 14065.9 826.5 835.3 840.5 847.3 847.3 852.3 854.2 855.0 860.2 860.3 891.9 892.1 893.6 893.9 898.2 879.4 889.1 889.2 889.4 889.5 654.9 655.9 656.9 657.5 661.4 15291.2 15322.2 15450.9 15457.4 15468.8 13328.7 13420.5 13679.9 13732.2 13799.4 11465.5 11550.2 11716.1 12014.6 12083.6 3878.7 3886.8 3896.7 3907.2 4050.1 47945.5 47999.0 48153.0 48576.8 49131.0 10032.6 10282.2 10369.0 10372.3 10444.8 18289.9 18442.8 18862.6 18875.2 18946.1 7943.9 8069.3 8076.3 8117.3 8319.9 4640.2 4782.4 4791.4 4808.4 4818.6 3067.0 3103.7 3107.5 3124.6 3125.8 564.5 586.8 590.0 592.7 606.5 589.9 754.5 759.2 770.9 780.3 9283.8 9290.8 9382.5 9409.5 9421.3 629.8 669.8 745.2 757.0 766.8 4246.8 4320.2 4358.1 4491.8 4772.2 51076.7 53959.7 54163.7 54246.5 54386.2 51372.2 51397.7 51654.7 52468.5 52950.7 46816.8 47144.3 47178.3 48750.8 48871.5 9516.9 9559.9 9616.0 9657.7 9837.8 36255.3 37050.8 37111.8 37633.6 38683.8 47038.0 47224.3 47440.8 47764.8 47961.5 12081.3 12087.2 12205.1 12428.6 12623.2 13307.9 13380.0 13472.7 13918.7 13971.9 12741.6 12744.3 12950.5 12996.2 13157.4 12436.1 12595.9 12913.8 12948.4 13275.7 12419.5 12682.4 12820.4 13105.6 13197.5 10540.6 10563.5 10797.9 10966.6 11057.6 10592.3 10836.8 10889.6 10895.2 10942.8 05:29:25 INFO - PROCESS | 16085 | -------- Summary: end -------- 05:29:25 INFO - PROCESS | 16085 | 05:29:25 INFO - TEST-INFO | 16085: exit 0 05:29:25 INFO - TEST-OK | dromaeo_css | took 1108087ms 05:29:25 INFO - TEST-START | kraken 05:29:25 INFO - operating with platform_type : linux_ 05:29:25 INFO - Initialising browser for kraken test... 05:29:25 INFO - TEST-INFO | started process 16324 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptzpRSw/profile http://localhost:45416/getInfo.html) 05:29:29 INFO - PROCESS | 16324 | 05:29:29 INFO - PROCESS | 16324 | (process:16402): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:30 INFO - PROCESS | 16324 | __metrics Screen width/height:1600/1200 05:29:30 INFO - PROCESS | 16324 | colorDepth:24 05:29:30 INFO - PROCESS | 16324 | Browser inner width/height: 1024/697 05:29:30 INFO - PROCESS | 16324 | __metrics 05:29:30 INFO - TEST-INFO | 16324: exit 0 05:29:30 INFO - Browser initialized. 05:29:30 INFO - Running cycle 1/1 for kraken test... 05:29:30 INFO - TEST-INFO | started process 16451 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmptzpRSw/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:32 INFO - PROCESS | 16451 | 05:29:32 INFO - PROCESS | 16451 | (process:16519): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:42 INFO - PROCESS | 16451 | RSS: Main: 140894208 05:29:42 INFO - PROCESS | 16451 | 05:29:45 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45416/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:45 INFO - PROCESS | 16451 | RSS: Main: 146296832 05:29:45 INFO - PROCESS | 16451 | 05:29:48 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45416/tests/kraken/driver.html?testName=audio-dft) 05:29:49 INFO - PROCESS | 16451 | RSS: Main: 145195008 05:29:49 INFO - PROCESS | 16451 | 05:29:51 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45416/tests/kraken/driver.html?testName=audio-fft) 05:29:52 INFO - PROCESS | 16451 | RSS: Main: 145481728 05:29:52 INFO - PROCESS | 16451 | 05:29:54 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45416/tests/kraken/driver.html?testName=audio-oscillator) 05:29:55 INFO - PROCESS | 16451 | RSS: Main: 145301504 05:29:55 INFO - PROCESS | 16451 | 05:29:57 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45416/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:57 INFO - PROCESS | 16451 | RSS: Main: 145440768 05:29:57 INFO - PROCESS | 16451 | 05:30:00 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45416/tests/kraken/driver.html?testName=imaging-darkroom) 05:30:01 INFO - PROCESS | 16451 | RSS: Main: 145346560 05:30:01 INFO - PROCESS | 16451 | 05:30:04 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45416/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:05 INFO - PROCESS | 16451 | RSS: Main: 145563648 05:30:05 INFO - PROCESS | 16451 | 05:30:08 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45416/tests/kraken/driver.html?testName=json-parse-financial) 05:30:08 INFO - PROCESS | 16451 | RSS: Main: 145379328 05:30:08 INFO - PROCESS | 16451 | 05:30:10 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45416/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:10 INFO - PROCESS | 16451 | RSS: Main: 146374656 05:30:10 INFO - PROCESS | 16451 | 05:30:12 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:13 INFO - PROCESS | 16451 | RSS: Main: 145776640 05:30:13 INFO - PROCESS | 16451 | 05:30:15 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:15 INFO - PROCESS | 16451 | RSS: Main: 145977344 05:30:15 INFO - PROCESS | 16451 | 05:30:18 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:18 INFO - PROCESS | 16451 | RSS: Main: 145326080 05:30:18 INFO - PROCESS | 16451 | 05:30:21 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:21 INFO - PROCESS | 16451 | RSS: Main: 146956288 05:30:21 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | Cycle 1(1): loaded http://localhost:45416/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45416/tests/kraken/driver.html?testName=ai-astar) 05:30:23 INFO - PROCESS | 16451 | RSS: Main: 148094976 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | __start_tp_report 05:30:23 INFO - PROCESS | 16451 | _x_x_mozilla_page_load 05:30:23 INFO - PROCESS | 16451 | _x_x_mozilla_page_load_details 05:30:23 INFO - PROCESS | 16451 | |i|pagename|runs| 05:30:23 INFO - PROCESS | 16451 | |0;ai-astar;111;106;112;111;110;122;110;110;111;111 05:30:23 INFO - PROCESS | 16451 | |1;audio-beat-detection;159;127;150;157;128;146;154;127;161;127 05:30:23 INFO - PROCESS | 16451 | |2;audio-dft;166;163;163;161;162;164;161;163;165;163 05:30:23 INFO - PROCESS | 16451 | |3;audio-fft;86;73;75;157;74;73;76;76;161;74 05:30:23 INFO - PROCESS | 16451 | |4;audio-oscillator;95;96;142;95;95;96;144;95;95;136 05:30:23 INFO - PROCESS | 16451 | |5;imaging-gaussian-blur;110;112;110;110;110;110;111;111;110;110 05:30:23 INFO - PROCESS | 16451 | |6;imaging-darkroom;147;147;149;147;146;148;147;146;148;147 05:30:23 INFO - PROCESS | 16451 | |7;imaging-desaturate;97;96;96;97;96;96;98;97;96;96 05:30:23 INFO - PROCESS | 16451 | |8;json-parse-financial;56;56;58;55;55;59;55;64;53;56 05:30:23 INFO - PROCESS | 16451 | |9;json-stringify-tinderbox;64;64;64;65;64;63;64;65;65;64 05:30:23 INFO - PROCESS | 16451 | |10;stanford-crypto-aes;83;81;84;81;83;82;83;82;84;83 05:30:23 INFO - PROCESS | 16451 | |11;stanford-crypto-ccm;113;110;120;120;111;113;115;116;119;111 05:30:23 INFO - PROCESS | 16451 | |12;stanford-crypto-pbkdf2;141;144;141;136;138;139;138;141;140;126 05:30:23 INFO - PROCESS | 16451 | |13;stanford-crypto-sha256-iterative;70;64;76;67;63;66;68;67;64;63 05:30:23 INFO - PROCESS | 16451 | __end_tp_report 05:30:23 INFO - PROCESS | 16451 | __start_cc_report 05:30:23 INFO - PROCESS | 16451 | _x_x_mozilla_cycle_collect,735 05:30:23 INFO - PROCESS | 16451 | __end_cc_report 05:30:23 INFO - PROCESS | 16451 | __startTimestamp1456579823799__endTimestamp 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | ------- Summary: start ------- 05:30:23 INFO - PROCESS | 16451 | Number of tests: 14 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#0] ai-astar Cycles:10 Average:111.40 Median:111.00 stddev:4.06 (3.7%) stddev-sans-first:4.30 05:30:23 INFO - PROCESS | 16451 | Values: 111.0 106.0 112.0 111.0 110.0 122.0 110.0 110.0 111.0 111.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#1] audio-beat-detection Cycles:10 Average:143.60 Median:152.00 stddev:14.70 (9.7%) stddev-sans-first:14.50 05:30:23 INFO - PROCESS | 16451 | Values: 159.0 127.0 150.0 157.0 128.0 146.0 154.0 127.0 161.0 127.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:1.60 (1.0%) stddev-sans-first:1.30 05:30:23 INFO - PROCESS | 16451 | Values: 166.0 163.0 163.0 161.0 162.0 164.0 161.0 163.0 165.0 163.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#3] audio-fft Cycles:10 Average:92.50 Median:74.50 stddev:35.26 (47.3%) stddev-sans-first:37.32 05:30:23 INFO - PROCESS | 16451 | Values: 86.0 73.0 75.0 157.0 74.0 73.0 76.0 76.0 161.0 74.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#4] audio-oscillator Cycles:10 Average:108.90 Median:95.00 stddev:22.01 (23.2%) stddev-sans-first:22.77 05:30:23 INFO - PROCESS | 16451 | Values: 95.0 96.0 142.0 95.0 95.0 96.0 144.0 95.0 95.0 136.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#5] imaging-gaussian-blur Cycles:10 Average:110.40 Median:110.00 stddev:0.70 (0.6%) stddev-sans-first:0.73 05:30:23 INFO - PROCESS | 16451 | Values: 110.0 112.0 110.0 110.0 110.0 110.0 111.0 111.0 110.0 110.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 05:30:23 INFO - PROCESS | 16451 | Values: 147.0 147.0 149.0 147.0 146.0 148.0 147.0 146.0 148.0 147.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.50 stddev:0.71 (0.7%) stddev-sans-first:0.73 05:30:23 INFO - PROCESS | 16451 | Values: 97.0 96.0 96.0 97.0 96.0 96.0 98.0 97.0 96.0 96.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#8] json-parse-financial Cycles:10 Average:56.70 Median:56.00 stddev:3.06 (5.5%) stddev-sans-first:3.23 05:30:23 INFO - PROCESS | 16451 | Values: 56.0 56.0 58.0 55.0 55.0 59.0 55.0 64.0 53.0 56.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 05:30:23 INFO - PROCESS | 16451 | Values: 64.0 64.0 64.0 65.0 64.0 63.0 64.0 65.0 65.0 64.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:1.07 (1.3%) stddev-sans-first:1.13 05:30:23 INFO - PROCESS | 16451 | Values: 83.0 81.0 84.0 81.0 83.0 82.0 83.0 82.0 84.0 83.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#11] stanford-crypto-ccm Cycles:10 Average:114.80 Median:115.50 stddev:3.82 (3.3%) stddev-sans-first:4.00 05:30:23 INFO - PROCESS | 16451 | Values: 113.0 110.0 120.0 120.0 111.0 113.0 115.0 116.0 119.0 111.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.40 Median:140.50 stddev:4.88 (3.5%) stddev-sans-first:5.09 05:30:23 INFO - PROCESS | 16451 | Values: 141.0 144.0 141.0 136.0 138.0 139.0 138.0 141.0 140.0 126.0 05:30:23 INFO - PROCESS | 16451 | 05:30:23 INFO - PROCESS | 16451 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:3.97 (5.9%) stddev-sans-first:4.03 05:30:23 INFO - PROCESS | 16451 | Values: 70.0 64.0 76.0 67.0 63.0 66.0 68.0 67.0 64.0 63.0 05:30:23 INFO - PROCESS | 16451 | -------- Summary: end -------- 05:30:23 INFO - PROCESS | 16451 | 05:30:24 INFO - TEST-INFO | 16451: exit 0 05:30:24 INFO - TEST-OK | kraken | took 58737ms 05:30:24 INFO - TEST-START | v8_7 05:30:24 INFO - operating with platform_type : linux_ 05:30:24 INFO - Initialising browser for v8_7 test... 05:30:24 INFO - TEST-INFO | started process 16747 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph9yBp5/profile http://localhost:45416/getInfo.html) 05:30:27 INFO - PROCESS | 16747 | 05:30:27 INFO - PROCESS | 16747 | (process:16827): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:30:28 INFO - PROCESS | 16747 | __metrics Screen width/height:1600/1200 05:30:28 INFO - PROCESS | 16747 | colorDepth:24 05:30:28 INFO - PROCESS | 16747 | Browser inner width/height: 1024/697 05:30:28 INFO - PROCESS | 16747 | __metrics 05:30:29 INFO - TEST-INFO | 16747: exit 0 05:30:29 INFO - Browser initialized. 05:30:29 INFO - Running cycle 1/1 for v8_7 test... 05:30:29 INFO - TEST-INFO | started process 16876 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmph9yBp5/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:30:31 INFO - PROCESS | 16876 | 05:30:31 INFO - PROCESS | 16876 | (process:16939): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:30:41 INFO - PROCESS | 16876 | RSS: Main: 141164544 05:30:41 INFO - PROCESS | 16876 | 05:31:03 INFO - PROCESS | 16876 | Cycle 1(1): loaded http://localhost:45416/tests/v8_7/run.html (next: http://localhost:45416/tests/v8_7/run.html) 05:31:04 INFO - PROCESS | 16876 | RSS: Main: 145158144 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | __start_tp_report 05:31:04 INFO - PROCESS | 16876 | _x_x_mozilla_page_load 05:31:04 INFO - PROCESS | 16876 | _x_x_mozilla_page_load_details 05:31:04 INFO - PROCESS | 16876 | |i|pagename|runs| 05:31:04 INFO - PROCESS | 16876 | |0;Richards;167.81339150864238 05:31:04 INFO - PROCESS | 16876 | |1;DeltaBlue;170.2127659574468 05:31:04 INFO - PROCESS | 16876 | |2;Encrypt;278.9400278940028 05:31:04 INFO - PROCESS | 16876 | |3;Decrypt;5218.75 05:31:04 INFO - PROCESS | 16876 | |4;RayTrace;936.3295880149813 05:31:04 INFO - PROCESS | 16876 | |5;Earley;565.6108597285067 05:31:04 INFO - PROCESS | 16876 | |6;Boyer;11177.777777777777 05:31:04 INFO - PROCESS | 16876 | |7;RegExp;39000 05:31:04 INFO - PROCESS | 16876 | |8;Splay;506.32911392405066 05:31:04 INFO - PROCESS | 16876 | |9;NavierStokes;4850.241545893719 05:31:04 INFO - PROCESS | 16876 | __end_tp_report 05:31:04 INFO - PROCESS | 16876 | __startTimestamp1456579864182__endTimestamp 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | ------- Summary: start ------- 05:31:04 INFO - PROCESS | 16876 | Number of tests: 10 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#0] Richards Cycles:1 Average:167.81 Median:167.81 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 167.8 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#1] DeltaBlue Cycles:1 Average:170.21 Median:170.21 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 170.2 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#2] Encrypt Cycles:1 Average:278.94 Median:278.94 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 278.9 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#3] Decrypt Cycles:1 Average:5218.75 Median:5218.75 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 5218.8 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#4] RayTrace Cycles:1 Average:936.33 Median:936.33 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 936.3 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#5] Earley Cycles:1 Average:565.61 Median:565.61 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 565.6 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#6] Boyer Cycles:1 Average:11177.78 Median:11177.78 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 11177.8 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#7] RegExp Cycles:1 Average:39000.00 Median:39000.00 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 39000.0 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#8] Splay Cycles:1 Average:506.33 Median:506.33 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 506.3 05:31:04 INFO - PROCESS | 16876 | 05:31:04 INFO - PROCESS | 16876 | [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 05:31:04 INFO - PROCESS | 16876 | Values: 4850.2 05:31:04 INFO - PROCESS | 16876 | -------- Summary: end -------- 05:31:04 INFO - PROCESS | 16876 | 05:31:05 INFO - TEST-INFO | 16876: exit 0 05:31:05 INFO - TEST-OK | v8_7 | took 40368ms 05:31:05 INFO - SUITE-END | took 1207s 05:31:05 INFO - Completed test suite (00:20:07) 05:31:05 INFO - Working with test: dromaeo_css 05:31:05 INFO - Generating results file: dromaeo_css 05:31:05 INFO - Working with test: kraken 05:31:05 INFO - Generating results file: kraken 05:31:05 INFO - javascript benchmark 05:31:05 INFO - Working with test: v8_7 05:31:05 INFO - Generating results file: v8_7 05:31:05 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:05 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 05:31:05 INFO - process_Request line: dromaeo_css 7228.91 graph.html#tests=[[72,52,43]] 05:31:05 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:05 INFO - process_Request line: kraken 1497.10 graph.html#tests=[[232,52,43]] 05:31:05 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:05 INFO - process_Request line: v8_7 22017.52 graph.html#tests=[[230,52,43]] 05:31:05 INFO - RETURN: dromaeo_css: 7228.91 05:31:05 INFO - RETURN: kraken: 1497.10 05:31:05 INFO - RETURN: v8_7: 22017.52 05:31:05 INFO - javascript benchmark 05:31:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3284.8193349365793, 3364.966350336496, 3373.2578832656823, 3411.7952922824634, 3413.1978984938537, 5456.61803673743, 5504.394516603175, 5525.557955363572, 5525.696086715229, 5545.584081193916, 5469.343678758554, 5544.417836127209, 5555.027870122733, 5557.194206840016, 5563.221149039127, 4947.628927830409, 5046.596272298208, 5119.795208191668, 5119.920219396659, 5175.508326708957, 4814.9037019259595, 4964.329815474901, 4992.550670439659, 5004.949950500485, 5070.442251352349, 5008.649394542384, 5053.570446512051, 5057.873553161164, 5068.594512439015, 5072.26452164436, 5026.120428924942, 5036.0, 5048.444671086178, 5068.898622027557, 5071.0, 4811.4707382187935, 4851.684640498356, 4900.995295964354, 4937.851864444036, 4961.08219979305, 5138.049460849755, 5173.456787037345, 5181.248718935771, 5216.921746173811, 5242.7378631068295, 5811.27359080115, 5827.766889324422, 5845.503132233765, 5850.882982340372, 5874.853128671774, 5701.116326969326, 5779.479846813807, 5817.476427121537, 5882.823515294548, 5981.282246130449, 5466.988607107698, 5472.835814925558, 5483.588730845203, 5508.788066625376, 5531.889362212773, 5990.221271234712, 5994.610350327215, 6003.8198854034445, 6004.42957918997, 6005.669688167105, 5586.162075688598, 5617.831465055973, 5636.746346414421, 5732.111522713986, 5739.713014349266, 5825.970870145707, 5828.795992140254, 5832.737526811219, 5835.883282334329, 5876.676782776988, 5690.573207009408, 5783.421657834183, 5811.3316968548315, 5814.767409303665, 5816.127580862904, 5759.164921086419, 5798.304203495608, 5826.970865145732, 5901.203337549462, 5928.199693041384, 4477.261251893467, 4492.618127459137, 4494.37078808967, 4505.121501307213, 4509.706869053567, 3975.0658595230097, 3990.06233535119, 4065.7560546367313, 4074.022234663659, 4087.346024636044, 5417.295751552273, 5483.862903427366, 5502.807401741, 5516.862078447991, 5543.6396634218645, 5735.627184233012, 5821.563382746311, 5831.067029275296, 5885.823425297248, 5901.76392944286, 5426.9185962210595, 5454.7818087276855, 5538.0, 5555.055640541118, 5555.3611334697025, 5102.617303702237, 5116.513931176532, 5118.846434606968, 5120.334356533627, 5125.2568377585785, 6043.335233124353, 6051.576389652682, 6076.696165191811, 6101.725422356005, 6110.694465276719, 5778.8844223114465, 5838.708064596668, 5853.356130825691, 5890.793822216202, 5955.017422125301, 5947.197128387786, 5974.910376344272, 5980.910286345621, 6010.278766548042, 6037.215162028908, 5744.0522313817755, 5764.654120752768, 5769.826905192851, 5780.248567686174, 5807.332156801853, 5733.0, 5735.11105778605, 5873.706314684163, 5932.851678708067, 6007.249093863267, 5687.203791469115, 5690.3456102548735, 5690.459406356389, 5716.371199168171, 5719.3136823581435, 5599.216109744558, 5682.602217844877, 5685.715714214355, 5703.62926409782, 5713.571482138773, 5514.641548299348, 5625.043742563692, 5674.886502270014, 5683.005474042109, 5718.714064296852, 5722.799702010409, 5732.455416735404, 5754.877798829188, 5777.335606405317, 5804.390538993345, 5489.313835770528, 5550.4449555044175, 5638.295213098363, 5649.096144617006, 5670.291213598301], "unit": "score", "name": "dojo.html", "value": 5399.500516009083}, {"lowerIsBetter": false, "replicates": [543.6982474726527, 554.2157846646995, 558.7122631844599, 585.3414908228243, 621.4748537485824, 33118.33763324732, 37315.44026839596, 37442.0, 37483.4377484338, 37598.24803503928, 39827.40258896119, 40283.79858100705, 40324.59675403245, 40663.0, 40710.79644601773, 8750.737477875658, 8964.417312874675, 9006.099390061006, 9027.95486022569, 9037.683681071163, 8711.34664900135, 8755.124487551258, 8809.471431714086, 8832.381733278673, 9026.413283136575, 9043.186113249807, 9043.457392556467, 9052.140046695586, 9152.633894644207, 9196.724098277062, 8934.821303573925, 9038.18656320931, 9050.728478145666, 9069.863952040758, 9085.954570227173, 8918.464892106429, 8960.820783584291, 8965.641374345018, 8968.820623587557, 9007.549622518847, 41232.79383603063, 41444.1711165778, 41799.37300940488, 41850.37224441636, 41915.58084419147, 3490.7905525668543, 3551.200979779555, 3644.234710710754, 3825.196708691178, 4097.590240975908, 31149.532757008663, 31402.0, 31616.36767264642, 31890.043298700843, 31893.362132757447, 4147.958520414787, 4250.277452832995, 4292.0772034012525, 4303.720258183208, 4307.569243075699, 274088.0, 275416.0, 275625.0, 275874.0, 276576.99999999796, 42933.35599966003, 43433.56566434359, 43661.0, 43746.0, 43782.781086094365, 40483.0, 40745.0, 41011.179776404904, 41077.79461102675, 41124.0, 16166.595835104217, 16334.918325408535, 16387.67224655524, 16415.343386264656, 16561.6687666246, 12194.756104877853, 12435.75128497425, 12447.128700990843, 12460.626181214579, 12818.166819156724, 14953.0, 14977.176255305845, 15059.322330495153, 15060.54818355451, 15077.246137693071, 6017.638941663514, 6131.816045518642, 6151.0, 6214.37856214384, 6282.340354262828, 1002.7015015554874, 1022.6420752736632, 1080.5839751695496, 1135.3471753741633, 1141.6289705845634, 29959.0, 30021.849890750407, 30045.549316760265, 30447.847760761055, 30998.380032399225, 1124.0670243697712, 1127.3855748617023, 1140.788954043488, 1205.5177928828364, 1254.7678679444332, 15660.92169539145, 15840.44558440449, 15894.841051589567, 16108.436204732778, 16225.837741622669, 318107.0, 740868.0, 742733.0, 749146.0, 749838.0, 57417.42582574121, 57617.0, 57663.13505297424, 58022.7098864503, 58469.41530584725, 1461.6492041910078, 1495.0431723696624, 1498.5054931872455, 1508.2232650185163, 1515.3484001879299, 30666.0, 30697.693023069485, 30751.0, 31291.374172516877, 31762.682373175972, 48170.759146204044, 48295.0, 48557.514424856716, 48604.0, 48787.756061219465, 291707.0, 291711.0, 291779.0, 292283.0, 293431.0, 32651.836740816143, 33606.49590256197, 33624.0, 33756.66243337535, 33921.15197119993, 40310.798446008754, 44109.0, 44670.55329446664, 44913.10173796571, 44950.55049449595, 37480.0, 37755.62244377521, 37767.62232377751, 38548.229035419696, 38637.0, 37282.627173729, 37737.97645180559, 37885.62114378821, 37991.43012854864, 38365.80817095897, 37009.44485832768, 37608.43587346137, 37925.24149517049, 38036.42945355766, 38132.23735525218, 33488.16279593029, 33564.832175838965, 33569.0, 33890.0, 33944.0, 26048.8697556511, 26458.86770566135, 26578.7342126584, 26634.334141646614, 26956.595651064858], "unit": "score", "name": "ext.html", "value": 18979.104968663505}, {"lowerIsBetter": false, "replicates": [388.68516501633695, 390.4865102390356, 392.5387669488351, 394.16437153235137, 402.6034356159181, 15542.067475951451, 16372.672546549062, 17084.060376679277, 17818.0, 17861.553461163476, 10664.093552048085, 11088.501017454213, 11187.776244475106, 14426.783598246035, 17552.0346380949, 4980.626453016029, 5014.2979982802435, 5127.435982041991, 5186.092433824085, 5188.247704082905, 5063.594912407017, 5313.256144139824, 5454.372747134091, 5491.313585801775, 5497.257870187534, 5419.674819510822, 5448.809291674792, 5484.780608775644, 5492.340919089715, 5618.522425593829, 5579.972100139494, 5592.3009623797025, 5606.887862242773, 5608.214849921014, 5636.464535869086, 5336.252924590561, 5429.619926605139, 5507.586930980153, 5521.033819081645, 5600.831975040755, 12551.874481255161, 12712.809307860389, 17080.57298567546, 21586.460338491663, 21610.89194554033, 2209.0942713487393, 2249.3701763506247, 2257.390504563775, 2333.94165145871, 2349.7180338359335, 9438.622455101857, 9476.0, 9482.099200575934, 9718.757031074208, 13167.934160329232, 1874.5126267170497, 1886.9716954245698, 1898.905054747257, 1946.7177259297323, 1966.8819870807654, 57945.0, 57957.0, 59330.40669593292, 59888.70055649737, 60223.0, 10846.18653600983, 10865.891341086488, 10900.236983411243, 10927.453627318602, 10999.450027498593, 14324.856751432353, 14329.211893345966, 14345.139291642536, 14360.138391696531, 14384.712305754036, 7493.625318734042, 7583.658735356922, 7766.068071831416, 7788.415868809862, 7826.3347615452185, 7376.188619251878, 7379.483436159418, 7382.778516644509, 7410.592417417094, 7444.255574442513, 4295.205387003414, 4747.881302967454, 4752.239641657387, 4780.880477988078, 4800.231962885921, 1876.3714155757973, 1904.6762050451457, 2011.5876245369664, 2022.7067075274297, 2032.1160295271309, 939.4269495607674, 993.5777294649889, 1066.671993368246, 1084.3819023156725, 1101.168617693652, 16155.192240387934, 16662.916685416494, 16691.749623755655, 17061.48815535536, 17292.04893730857, 1026.779242462874, 1048.2871647279924, 1057.7302787789217, 1073.2969904712427, 1092.639428988432, 9563.856542151872, 9999.200063994864, 10572.788544229226, 10625.5218515167, 10653.78692426147, 513144.0, 514250.0, 517634.0, 517880.97344469, 523950.0, 73682.0, 75314.0, 75474.6226268876, 75510.24489755143, 76762.6161869187, 1192.9403529823473, 1198.1493139870615, 1215.8905698487001, 1224.4367590908105, 1227.6808029912288, 16167.514974550782, 16193.95609332394, 16253.918730406273, 16349.918250408671, 16566.088865112535, 31758.841205793822, 34152.14619634529, 35061.649383505835, 35116.82441587776, 35498.0, 37271.62728372682, 46542.0, 46830.0, 49494.75252623714, 52055.47944520506, 10099.29304948676, 10545.261831672016, 11088.611898583511, 11285.661430157108, 11403.144764142557, 8069.7175598853755, 8743.693970710994, 9014.368994170345, 12423.875761242272, 12929.0, 8016.318612917968, 8296.585170741559, 8342.207490288412, 8394.664213431395, 8402.621882015203, 7962.402819788424, 8191.754247372588, 8331.625076871434, 8486.448380855225, 8499.702510412106, 8109.189081091844, 8298.585070746318, 8486.108958559262, 8509.106543813057, 8528.403011789114, 10543.31468454548, 10700.839487407851, 10858.511366988663, 10892.346459212473, 11011.064059555027, 11033.22767406306, 11217.102631789274, 11422.600208992646, 11487.425628718363, 11499.08007359426], "unit": "score", "name": "jquery.html", "value": 8487.302535895375}, {"lowerIsBetter": false, "replicates": [1454.3310077364413, 1480.8000919875813, 1664.5422508810075, 1807.3854889337622, 1850.3986204483547, 7841.882371764428, 7942.801429964254, 8055.26811735476, 8056.0, 8115.431919765619, 8058.677652893877, 8063.31461825744, 8185.672573097084, 8199.303059239957, 8207.753767386974, 2390.043982407042, 2416.178499310234, 2435.610302351624, 2437.9756202438016, 2444.010175878772, 2405.6271277951946, 2441.6703744994375, 2445.9143929962456, 2448.2532827487607, 2453.6319552067152, 2358.398608354867, 2405.458771776354, 2406.2300063979533, 2428.7206971198275, 2431.781139697427, 2437.731849496554, 2445.303088619744, 2465.778079972793, 2470.419451428913, 2475.4553998120386, 2423.297243799296, 2430.829841911067, 2435.281591930385, 2442.6091825307867, 2455.373879660693, 7956.562389068599, 7977.042754869452, 8018.839623207561, 8019.0, 8047.597620119029, 4903.092927808367, 5030.270610761456, 5030.924536131961, 5109.897802043975, 5114.488551144856, 3227.6288226853976, 3229.160418291238, 3241.8054916705073, 3246.3994161080277, 3348.5312056312137, 1049.685094471663, 1064.1433645915035, 1092.595739576362, 1103.1450625765017, 1123.6516679829197, 11102.111831053497, 11121.777564448666, 11163.665090047312, 11195.440227988567, 11201.159913006557, 4316.201502722007, 4345.500267469281, 4375.584319489643, 4431.623312018514, 4444.11117776446, 9058.909410905806, 9062.410943288665, 9067.365284430027, 9085.091490850862, 9088.81822363549, 4935.506449355035, 4963.851084467472, 5005.5745261653165, 5023.547880690682, 5041.369828771403, 4597.609203217697, 4617.6536759742485, 4670.626349892001, 4673.345731597579, 4698.107359601733, 3640.8361623726996, 3650.7261955353456, 3695.7597756145765, 3696.963030369716, 3712.7586706863967, 1107.0921844087932, 1112.7718817642526, 1121.8429419881222, 1129.768397478515, 1179.0744265751516, 1049.8792638846478, 1084.4252546150553, 1087.7063192938022, 1286.9935650321688, 1379.2827729580563, 7456.067991501062, 7481.812954676177, 7524.548527088283, 7552.471327007057, 7604.2395760423515, 1167.258790667915, 1181.8640856301463, 1199.1665792274287, 1200.591798788416, 1211.8909298163207, 5908.261467316585, 6016.037434010625, 6078.331383547807, 6080.878382432326, 6122.326544080237, 9417.48203848795, 9994.200463962865, 10012.0, 10072.949635251924, 10147.34042287249, 9781.510924453749, 9875.111239988435, 9881.950590247146, 9926.851097233548, 10024.899751002542, 7602.885956710654, 7705.57619330931, 7751.844963100819, 7820.7653770388115, 7839.9216007839195, 7569.772906812805, 7614.961925190339, 7643.350315223268, 7646.579438130733, 7700.306972372289, 8587.141285871363, 8739.475631462132, 8789.296856251613, 8854.601542930455, 8860.689875854314, 8873.423227490193, 8959.238464730572, 9005.0, 9116.498592577473, 9165.404248723811, 7408.0, 7559.773206803805, 7568.659410326439, 7578.09062912454, 7578.886316705364, 7708.653110610148, 7713.074431068308, 7733.265339792711, 7978.361731061617, 8034.437589368688, 6678.065070889982, 7588.317051465395, 7646.120696120018, 7646.847063058819, 7694.192109828611, 6846.726130954706, 6858.4856135791015, 6921.757738479129, 6969.407600354027, 7044.577325360495, 6958.408535274559, 7074.858502829811, 7087.68105435267, 7095.184053833668, 7101.786946391617, 6555.541112122296, 6559.967200163968, 6572.901406478811, 6590.50571207171, 6623.437007854386, 6666.600003999775, 6671.733130674718, 6708.161479815023, 6750.729970801113, 6752.155980502437], "unit": "score", "name": "mootools.html", "value": 4700.097242538484}, {"lowerIsBetter": false, "replicates": [356.5721134638434, 364.94708267301223, 365.444524323029, 366.9908252293694, 369.4421423650289, 6283.120363149163, 6371.108044873716, 6393.584417012897, 6414.583052101621, 6464.482841372691, 6205.22434695663, 6333.113364129025, 6350.904736428957, 6394.040893865911, 6399.712012959416, 4847.878803029935, 4869.318295438641, 4886.096072226632, 4893.290472881439, 4894.412670479547, 4886.071646387193, 4890.315355850184, 4892.217245240762, 4902.828401005965, 4905.705657660552, 4719.669623126365, 4857.417109946811, 4858.0, 4862.319275301461, 4862.659613827033, 4812.759362031885, 4819.228923372244, 4829.637777166709, 4848.903021939542, 4852.126617208936, 4236.004538933348, 4236.936445953283, 4237.915241695179, 4240.194363071007, 4254.212970600418, 6025.969870150665, 6098.420650038283, 6104.542159338023, 6123.418275263843, 6149.446549810494, 5651.06757385031, 5661.631993920423, 5668.404817494145, 5679.864027194536, 5681.375048744635, 6746.190457145174, 6746.561473504206, 6749.19009718832, 6752.864942701168, 6753.45972322213, 4688.2733176357715, 4708.152532544175, 4712.9057418851435, 4723.4331880174595, 4751.3585665935, 6922.58464492132, 7016.228214896358, 7064.752733654349, 7095.609741464217, 7115.75094871677, 4791.377120974321, 4808.182608956486, 4821.252705830602, 4822.590079843252, 4830.058138662997, 4889.168841296988, 4893.804247830047, 4895.485973972753, 4895.730734809548, 4900.215965445583, 5497.9828731684765, 5653.180288858092, 5663.830085097454, 5671.234383358276, 5673.432656734376, 6810.761623343159, 6837.521373503807, 6838.247792742794, 6865.656717164122, 6868.484863635247, 1691.4249155287016, 1717.957051073708, 1730.7144321187116, 1731.039273203359, 1738.9217485213196, 1151.1596534529672, 1163.3485248261002, 1171.1509155862102, 1183.9171258011856, 1187.2935603316014, 6494.4479719223455, 6523.739050438025, 6529.510286728514, 6568.704408301638, 6580.177477815273, 6956.0, 6962.965185174143, 7013.6142512161305, 7031.191412987469, 7036.6129862857015, 6453.935460645427, 6535.8692826143215, 6552.967235163794, 6556.672166391661, 6578.769743059066, 3779.5464544254864, 3795.1081495848453, 3801.258754542893, 3805.752626079296, 3813.9809300953316, 7258.455615828834, 7265.128184617774, 7267.563946163247, 7268.927310726931, 7280.235575264521, 7002.649867506604, 7160.928390716026, 7166.211716711157, 7180.712771489187, 7196.532225405332, 7130.215676275606, 7199.920011998242, 7225.819354516179, 7231.529950553302, 7251.1661158966335, 6945.617991010543, 6951.27011663768, 6976.337247961435, 6989.440844732308, 7009.264027277062, 6790.151231096113, 6876.553024053421, 6881.552699074544, 7009.264027277062, 7039.260877607778, 7323.377512911249, 7376.7786966391095, 7384.556926584422, 7385.446091543048, 7391.0761154855645, 4832.565069143653, 4872.561469467765, 4879.999600082046, 4880.95119048805, 4902.975485122552, 6988.126484189476, 7035.47233957445, 7077.752278670222, 7094.609796461038, 7170.1754298256365, 6908.896366554405, 6930.861382772216, 6969.059177011241, 6972.442204623517, 7018.6490675465, 6905.551139175937, 6916.619585922823, 6952.513324067267, 6959.686814093479, 6962.547434416747, 6685.431738302299, 6801.319868013159, 6806.523543351917, 6820.693068812015, 6825.931740682529, 6941.965290173517, 6953.443724501926, 6981.650917454005, 6996.965015174892, 6997.825054373681, 6756.087928129836, 6767.424768894502, 6797.150356205474, 6806.2513123557355, 6811.2631279023535], "unit": "score", "name": "prototype.html", "value": 5143.28490178561}, {"lowerIsBetter": false, "replicates": [785.308928143234, 791.9960400197998, 876.2726936642588, 921.7649499377662, 934.5841100710187, 14696.926515367435, 14733.410663573444, 14746.557603271893, 14805.55583332499, 14836.184009879453, 13442.798358024638, 13955.092918960261, 14018.719625607482, 14051.367688454018, 14065.859341406584, 826.5288785392329, 835.2858306148247, 840.4705035827451, 847.3136759225048, 847.3475423923575, 852.3309202276214, 854.2269246332079, 855.0380821575727, 860.1527495417009, 860.3375400941303, 891.9152680495342, 892.1435421994893, 893.6023469556051, 893.9240164585985, 898.1826537850558, 879.4195830751673, 889.1153302464057, 889.208604342136, 889.4263200235877, 889.4618755652801, 654.9181352330959, 655.8589903170841, 656.9474442044625, 657.4510283912938, 661.381608196338, 15291.235438228045, 15322.23388830554, 15450.9227453862, 15457.381704731797, 15468.767968480483, 13328.666783330495, 13420.5302814402, 13679.931600342034, 13732.176069435765, 13799.448022079105, 11465.54137834494, 11550.191486595857, 11716.121290903217, 12014.63956081319, 12083.637490875288, 3878.6897048236074, 3886.844526218976, 3896.7467114637457, 3907.199024200032, 4050.1494686115657, 47945.52054479445, 47999.0, 48153.0, 48576.75711621455, 49131.0, 10032.598696052222, 10282.177425805918, 10369.0, 10372.325798823053, 10444.843327350096, 18289.90855045743, 18442.815571844378, 18862.62274754497, 18875.244990200237, 18946.052697365078, 7943.920560794434, 8069.314108300743, 8076.27313541784, 8117.310028647631, 8319.916800832036, 4640.234361330343, 4782.426108866958, 4791.401074865642, 4808.35087263222, 4818.638602104786, 3067.0492147434366, 3103.736182424474, 3107.5494053362136, 3124.5781819454537, 3125.8437078146003, 564.5483613109496, 586.8415527807554, 590.0352922970974, 592.7303077099996, 606.5238787551839, 589.8820235952827, 754.5208792416855, 759.2445516710798, 770.9306162445407, 780.3172224303735, 9283.767905802273, 9290.814183716422, 9382.48396338208, 9409.529523523797, 9421.340506164639, 629.8393909553126, 669.7823207457595, 745.1765798792364, 757.0, 766.8312971146339, 4246.808893599796, 4320.222359975234, 4358.128374325148, 4491.842785502492, 4772.188727916263, 51076.74461627668, 53959.73020134874, 54163.72918135463, 54246.45753542493, 54386.184207236925, 51372.22941655878, 51397.74301128545, 51654.741726291126, 52468.475315247124, 52950.73524632352, 46816.7659161702, 47144.29283560749, 47178.29232561514, 48750.756246218545, 48871.511284887405, 9516.857247141437, 9559.900611429775, 9615.951920240634, 9657.661981830603, 9837.803243934937, 36255.27489450249, 37050.814745926094, 37111.814440928705, 37633.62366376301, 38683.80658096691, 47038.0, 47224.2916356248, 47440.76279618718, 47764.7611761939, 47961.5203847971, 12081.275123492618, 12087.153899226969, 12205.084618653458, 12428.62714118578, 12623.179493332904, 13307.909070089594, 13380.0, 13472.663183420102, 13918.721625567634, 13971.860281397463, 12741.55404560836, 12744.299063551594, 12950.481980720666, 12996.220226786423, 13157.407916643582, 12436.067294952734, 12595.874041259836, 12913.806292905427, 12948.417321220757, 13275.66810829737, 12419.503219871103, 12682.365881706062, 12820.358982050673, 13105.606831795061, 13197.538086166938, 10540.578376865145, 10563.52464139131, 10797.946010269898, 10966.561337546409, 11057.557697692002, 10592.258541901992, 10836.783264334512, 10889.618863339745, 10895.182861285593, 10942.781144376908], "unit": "score", "name": "yui.html", "value": 6786.635955854447}], "name": "dromaeo_css", "value": 7228.906987719637}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 106.0, 112.0, 111.0, 110.0, 122.0, 110.0, 110.0, 111.0, 111.0], "unit": "score", "name": "ai-astar", "value": 111.4}, {"lowerIsBetter": true, "replicates": [159.0, 127.0, 150.0, 157.0, 128.0, 146.0, 154.0, 127.0, 161.0, 127.0], "unit": "score", "name": "audio-beat-detection", "value": 143.6}, {"lowerIsBetter": true, "replicates": [166.0, 163.0, 163.0, 161.0, 162.0, 164.0, 161.0, 163.0, 165.0, 163.0], "unit": "score", "name": "audio-dft", "value": 163.1}, {"lowerIsBetter": true, "replicates": [86.0, 73.0, 75.0, 157.0, 74.0, 73.0, 76.0, 76.0, 161.0, 74.0], "unit": "score", "name": "audio-fft", "value": 92.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 142.0, 95.0, 95.0, 96.0, 144.0, 95.0, 95.0, 136.0], "unit": "score", "name": "audio-oscillator", "value": 108.9}, {"lowerIsBetter": true, "replicates": [110.0, 112.0, 110.0, 110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 110.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 149.0, 147.0, 146.0, 148.0, 147.0, 146.0, 148.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 98.0, 97.0, 96.0, 96.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 58.0, 55.0, 55.0, 59.0, 55.0, 64.0, 53.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.7}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.2}, {"lowerIsBetter": true, "replicates": [83.0, 81.0, 84.0, 81.0, 83.0, 82.0, 83.0, 82.0, 84.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.6}, {"lowerIsBetter": true, "replicates": [113.0, 110.0, 120.0, 120.0, 111.0, 113.0, 115.0, 116.0, 119.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 114.8}, {"lowerIsBetter": true, "replicates": [141.0, 144.0, 141.0, 136.0, 138.0, 139.0, 138.0, 141.0, 140.0, 126.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.4}, {"lowerIsBetter": true, "replicates": [70.0, 64.0, 76.0, 67.0, 63.0, 66.0, 68.0, 67.0, 64.0, 63.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.8}], "name": "kraken", "value": 1497.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.81339150864238], "unit": "score", "name": "Richards", "value": 210.36461799999995}, {"lowerIsBetter": false, "replicates": [170.2127659574468], "unit": "score", "name": "DeltaBlue", "value": 388.4432500000001}, {"lowerIsBetter": false, "replicates": [278.9400278940028], "unit": "score", "name": "Encrypt", "value": 954.2588850000001}, {"lowerIsBetter": false, "replicates": [5218.75], "unit": "score", "name": "Decrypt", "value": 51.00474251497002}, {"lowerIsBetter": false, "replicates": [936.3295880149813], "unit": "score", "name": "RayTrace", "value": 790.3082519999997}, {"lowerIsBetter": false, "replicates": [565.6108597285067], "unit": "score", "name": "Earley", "value": 1178.3065839999997}, {"lowerIsBetter": false, "replicates": [11177.777777777777], "unit": "score", "name": "Boyer", "value": 59.6239264413519}, {"lowerIsBetter": false, "replicates": [39000.0], "unit": "score", "name": "RegExp", "value": 23.358589743589743}, {"lowerIsBetter": false, "replicates": [506.32911392405066], "unit": "score", "name": "Splay", "value": 160.94472500000003}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 22017.516405148664}]} 05:31:05 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "22017.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1497.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7228.91"}}} 05:31:05 INFO - Return code: 0 05:31:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:31:05 INFO - # TBPL SUCCESS # 05:31:05 INFO - Running post-action listener: _resource_record_post_action 05:31:05 INFO - Running post-run listener: _resource_record_post_run 05:31:06 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 501886976; Read time: 0; Write time: 365992 05:31:06 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 242368512; Read time: 0; Write time: 222872 05:31:06 INFO - run-tests - Wall time: 1209s; CPU: 13.0%; Read bytes: 0; Write bytes: 259518464; Read time: 0; Write time: 143120 05:31:06 INFO - Running post-run listener: _upload_blobber_files 05:31:06 INFO - Blob upload gear active. 05:31:06 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:31:06 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:31:06 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:31:06 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:31:07 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:07 INFO - (blobuploader) - INFO - Done attempting. 05:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:08 INFO - (blobuploader) - INFO - Done attempting. 05:31:08 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:08 INFO - Return code: 0 05:31:08 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:31:08 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04fd0c4ae28ad02071c379cba90f16b87248955e32e6ea172bf1c38956187a42f790cd343f988d3f046648d222384d1b56612aae575b01c322289d3781ec4648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b84470c3bfd40eac8fc0d739796bb81ffaf1a96a77bd7c4c22d44371b58f9a03b49c82efa0dac44ab3d1556a966a1611b2fa3cfe938fb994120e376179916065"} 05:31:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:31:08 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:31:08 INFO - Contents: 05:31:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04fd0c4ae28ad02071c379cba90f16b87248955e32e6ea172bf1c38956187a42f790cd343f988d3f046648d222384d1b56612aae575b01c322289d3781ec4648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b84470c3bfd40eac8fc0d739796bb81ffaf1a96a77bd7c4c22d44371b58f9a03b49c82efa0dac44ab3d1556a966a1611b2fa3cfe938fb994120e376179916065"} 05:31:08 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:08 INFO - Copying logs to upload dir... 05:31:08 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:31:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.500199 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2016-02-27 05:31:07.603655) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:07.607062) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04fd0c4ae28ad02071c379cba90f16b87248955e32e6ea172bf1c38956187a42f790cd343f988d3f046648d222384d1b56612aae575b01c322289d3781ec4648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b84470c3bfd40eac8fc0d739796bb81ffaf1a96a77bd7c4c22d44371b58f9a03b49c82efa0dac44ab3d1556a966a1611b2fa3cfe938fb994120e376179916065"} build_url:https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011441 build_url: 'https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/firefox-46.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04fd0c4ae28ad02071c379cba90f16b87248955e32e6ea172bf1c38956187a42f790cd343f988d3f046648d222384d1b56612aae575b01c322289d3781ec4648", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b84470c3bfd40eac8fc0d739796bb81ffaf1a96a77bd7c4c22d44371b58f9a03b49c82efa0dac44ab3d1556a966a1611b2fa3cfe938fb994120e376179916065"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:07.632273) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:07.632606) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1456578604.672255-430317089 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004698 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:07.720362) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:31:07.720873) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:31:07.721347) ========= ========= Total master_lag: 0.28 =========