builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-050 starttime: 1456578600.33 results: success (0) buildid: 20160225002727 builduid: ddb4a69f92634164953fbb89635fa9b7 revision: b131aaab8f2f65db173486af71fe969c5ceff6da ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.332657) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.333150) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.333473) ========= 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=6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test-pgo program finished with exit code 0 elapsedTime=0.002963 basedir: '/builds/slave/test-pgo' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.347702) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.347997) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.356899) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.357165) ========= 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=6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003793 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.405744) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.406052) ========= 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:00.406428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.406706) ========= 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=6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-02-27 05:10:01-- 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% 212M=0s 2016-02-27 05:10:01 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139362 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.558621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.558955) ========= 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=6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020653 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:00.606388) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-27 05:10:00.606754) ========= 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=6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-02-27 05:10:01,877 truncating revision to first 12 chars 2016-02-27 05:10:01,878 Setting DEBUG logging. 2016-02-27 05:10:01,878 attempt 1/10 2016-02-27 05:10:01,878 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:02,638 unpacking tar archive at: mozilla-aurora-b131aaab8f2f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.059716 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-27 05:10:01.677653) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:01.678014) ========= 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=6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False b131aaab8f2f65db173486af71fe969c5ceff6da program finished with exit code 0 elapsedTime=0.003420 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:01.728457) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:01.728916) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-27 05:10:01.739587) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-27 05:10:01.740229) ========= /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=6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:10:03 INFO - MultiFileLogger online at 20160227 05:10:03 in /builds/slave/test-pgo 05:10:03 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:03 INFO - Dumping config to /builds/slave/test-pgo/logs/localconfig.json. 05:10:03 INFO - {'append_to_log': False, 05:10:03 INFO - 'base_work_dir': '/builds/slave/test-pgo', 05:10:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:10:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test-pgo/oauth.txt', 05:10:03 INFO - 'branch': 'Mozilla-Aurora', 05:10:03 INFO - 'buildbot_json_path': 'buildprops.json', 05:10:03 INFO - 'config_files': ('talos/linux_config.py',), 05:10:03 INFO - 'default_actions': ('clobber', 05:10:03 INFO - 'read-buildbot-config', 05:10:03 INFO - 'download-and-extract', 05:10:03 INFO - 'populate-webroot', 05:10:03 INFO - 'create-virtualenv', 05:10:03 INFO - 'install', 05:10:03 INFO - 'run-tests'), 05:10:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:10:03 INFO - 'download_minidump_stackwalk': True, 05:10:03 INFO - 'download_symbols': 'ondemand', 05:10:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:10:03 INFO - 'tooltool.py': '/tools/tooltool.py', 05:10:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:10:03 INFO - '/tools/misc-python/virtualenv.py')}, 05:10:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:10:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:10:03 INFO - 'installer_path': 'installer.exe', 05:10:03 INFO - 'log_level': 'info', 05:10:03 INFO - 'log_name': 'talos', 05:10:03 INFO - 'log_to_console': True, 05:10:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:10:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:10:03 INFO - 'opt_config_files': (), 05:10:03 INFO - 'pip_index': False, 05:10:03 INFO - 'sps_profile': False, 05:10:03 INFO - 'sps_profile_interval': 0, 05:10:03 INFO - 'suite': 'dromaeojs-e10s', 05:10:03 INFO - 'system_bits': '32', 05:10:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:10:03 INFO - 'title': 'talos-linux64-ix-050', 05:10:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:10:03 INFO - 'use_talos_json': True, 05:10:03 INFO - 'virtualenv_path': '/builds/slave/test-pgo/build/venv', 05:10:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:10:03 INFO - 'work_dir': 'build'} 05:10:03 INFO - ##### 05:10:03 INFO - ##### Running clobber step. 05:10:03 INFO - ##### 05:10:03 INFO - Running pre-action listener: _resource_record_pre_action 05:10:03 INFO - Running main action method: clobber 05:10:03 INFO - rmtree: /builds/slave/test-pgo/build 05:10:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test-pgo/build',), kwargs: {}, attempt #1 05:10:04 INFO - Running post-action listener: _resource_record_post_action 05:10:04 INFO - ##### 05:10:04 INFO - ##### Running read-buildbot-config step. 05:10:04 INFO - ##### 05:10:04 INFO - Running pre-action listener: _resource_record_pre_action 05:10:04 INFO - Running main action method: read_buildbot_config 05:10:04 INFO - Using buildbot properties: 05:10:04 INFO - { 05:10:04 INFO - "project": "", 05:10:04 INFO - "product": "firefox", 05:10:04 INFO - "script_repo_revision": "production", 05:10:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 05:10:04 INFO - "repository": "", 05:10:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 05:10:04 INFO - "buildid": "20160225002727", 05:10:04 INFO - "pgo_build": "True", 05:10:04 INFO - "basedir": "/builds/slave/test-pgo", 05:10:04 INFO - "buildnumber": 94, 05:10:04 INFO - "slavename": "talos-linux64-ix-050", 05:10:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 05:10:04 INFO - "platform": "ubuntu64_hw", 05:10:04 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 05:10:04 INFO - "branch": "mozilla-aurora", 05:10:04 INFO - "repo_path": "releases/mozilla-aurora", 05:10:04 INFO - "revision": "b131aaab8f2f65db173486af71fe969c5ceff6da", 05:10:04 INFO - "stage_platform": "linux64-pgo", 05:10:04 INFO - "builduid": "ddb4a69f92634164953fbb89635fa9b7", 05:10:04 INFO - "slavebuilddir": "test" 05:10:04 INFO - } 05:10:04 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:04 INFO - Running post-action listener: _resource_record_post_action 05:10:04 INFO - ##### 05:10:04 INFO - ##### Running download-and-extract step. 05:10:04 INFO - ##### 05:10:04 INFO - Running pre-action listener: _resource_record_pre_action 05:10:04 INFO - Running main action method: download_and_extract 05:10:04 INFO - mkdir: /builds/slave/test-pgo/build/tests 05:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:04 INFO - https://queue.taskcluster.net/v1/task/fmLUBwn6RcCoZ_iX1r_PZg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:10:04 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:04 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:04 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:04 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:04 INFO - Downloaded 1448 bytes. 05:10:04 INFO - Reading from file /builds/slave/test-pgo/build/test_packages.json 05:10:04 INFO - Using the following test package requirements: 05:10:04 INFO - {u'common': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:10:04 INFO - u'cppunittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:04 INFO - u'firefox-46.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 05:10:04 INFO - u'gtest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:04 INFO - u'firefox-46.0a2.en-US.linux-x86_64.gtest.tests.zip'], 05:10:04 INFO - u'jittest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:04 INFO - u'jsshell-linux-x86_64.zip'], 05:10:04 INFO - u'mochitest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:04 INFO - u'firefox-46.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 05:10:04 INFO - u'mozbase': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:10:04 INFO - u'reftest': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:04 INFO - u'firefox-46.0a2.en-US.linux-x86_64.reftest.tests.zip'], 05:10:04 INFO - u'talos': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:04 INFO - u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'], 05:10:04 INFO - u'web-platform': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:04 INFO - u'firefox-46.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 05:10:04 INFO - u'webapprt': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'], 05:10:04 INFO - u'xpcshell': [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', 05:10:04 INFO - u'firefox-46.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 05:10:04 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:10:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:04 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:04 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:04 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:04 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:04 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:05 INFO - Downloaded 23079153 bytes. 05:10:05 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:05 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:07 INFO - Return code: 0 05:10:07 INFO - Downloading packages: [u'firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:10:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:07 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:07 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:07 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:07 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:07 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:08 INFO - Downloaded 23079153 bytes. 05:10:08 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:10:08 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test-pgo/build/tests 05:10:09 INFO - Return code: 0 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.talos.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.talos.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.talos.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.talos.tests.zip to /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.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.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:10 INFO - Downloaded 10706572 bytes. 05:10:10 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test-pgo/build/tests'] 05:10:10 INFO - Copy/paste: unzip -q -o /builds/slave/test-pgo/build/firefox-46.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test-pgo/build/tests 05:10:10 INFO - Return code: 0 05:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:10 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:10 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:10 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:10 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:10 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:13 INFO - Downloaded 59961105 bytes. 05:10:13 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:13 INFO - mkdir: /builds/slave/test-pgo/properties 05:10:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test-pgo/properties/build_url 05:10:13 INFO - Writing to file /builds/slave/test-pgo/properties/build_url 05:10:13 INFO - Contents: 05:10:13 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:14 INFO - Running post-action listener: _resource_record_post_action 05:10:14 INFO - Running post-action listener: set_extra_try_arguments 05:10:14 INFO - ##### 05:10:14 INFO - ##### Running populate-webroot step. 05:10:14 INFO - ##### 05:10:14 INFO - Running pre-action listener: _resource_record_pre_action 05:10:14 INFO - Running main action method: populate_webroot 05:10:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:10:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:10:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:10:14 INFO - '--tppagecycles', 05:10:14 INFO - '7'], 05:10:14 INFO - 'tests': ['tsvgm']}}, 05:10:14 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:10:14 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:10:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:10:14 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:14 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:10:14 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:10:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:14 INFO - 'talos_options': ['--e10s'], 05:10:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:10:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:14 INFO - 'tests': ['damp', 'tps']}, 05:10:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:14 INFO - 'talos_options': ['--e10s'], 05:10:14 INFO - 'tests': ['damp', 'tps']}, 05:10:14 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:10:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:10:14 INFO - 'other': {'tests': ['a11yr', 05:10:14 INFO - 'ts_paint', 05:10:14 INFO - 'tpaint', 05:10:14 INFO - 'sessionrestore', 05:10:14 INFO - 'sessionrestore_no_auto_restore']}, 05:10:14 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:10:14 INFO - 'tests': ['a11yr', 05:10:14 INFO - 'ts_paint', 05:10:14 INFO - 'tpaint', 05:10:14 INFO - 'sessionrestore', 05:10:14 INFO - 'sessionrestore_no_auto_restore']}, 05:10:14 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:10:14 INFO - 'tests': ['a11yr', 05:10:14 INFO - 'ts_paint', 05:10:14 INFO - 'tpaint', 05:10:14 INFO - 'sessionrestore', 05:10:14 INFO - 'sessionrestore_no_auto_restore']}, 05:10:14 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:10:14 INFO - 'tests': ['a11yr', 05:10:14 INFO - 'ts_paint', 05:10:14 INFO - 'tpaint', 05:10:14 INFO - 'sessionrestore', 05:10:14 INFO - 'sessionrestore_no_auto_restore']}, 05:10:14 INFO - 'other_l64': {'tests': ['a11yr', 05:10:14 INFO - 'ts_paint', 05:10:14 INFO - 'tpaint', 05:10:14 INFO - 'sessionrestore', 05:10:14 INFO - 'sessionrestore_no_auto_restore']}, 05:10:14 INFO - 'other_nol64': {'tests': ['a11yr', 05:10:14 INFO - 'ts_paint', 05:10:14 INFO - 'tpaint', 05:10:14 INFO - 'sessionrestore', 05:10:14 INFO - 'sessionrestore_no_auto_restore']}, 05:10:14 INFO - 'svgr': {'tests': ['tsvgx', 05:10:14 INFO - 'tsvgr_opacity', 05:10:14 INFO - 'tart', 05:10:14 INFO - 'tscrollx', 05:10:14 INFO - 'cart']}, 05:10:14 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:10:14 INFO - 'tests': ['tsvgx', 05:10:14 INFO - 'tsvgr_opacity', 05:10:14 INFO - 'tart', 05:10:14 INFO - 'tscrollx', 05:10:14 INFO - 'cart']}, 05:10:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:14 INFO - 'tests': ['tp5o']}, 05:10:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:14 INFO - 'talos_options': ['--e10s'], 05:10:14 INFO - 'tests': ['tp5o']}, 05:10:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:14 INFO - 'talos_options': ['--xperf_path', 05:10:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:14 INFO - 'tests': ['tp5n']}, 05:10:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:10:14 INFO - 'talos_options': ['--e10s', 05:10:14 INFO - '--xperf_path', 05:10:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:10:14 INFO - 'tests': ['tp5n']}}, 05:10:14 INFO - 'talos.zip': {'path': '', 05:10:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:10:14 INFO - Running post-action listener: _resource_record_post_action 05:10:14 INFO - ##### 05:10:14 INFO - ##### Running create-virtualenv step. 05:10:14 INFO - ##### 05:10:14 INFO - Running pre-action listener: _resource_record_pre_action 05:10:14 INFO - Running main action method: create_virtualenv 05:10:14 INFO - Creating virtualenv /builds/slave/test-pgo/build/venv 05:10:14 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:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test-pgo/build/venv 05:10:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:10:14 INFO - Using real prefix '/usr' 05:10:14 INFO - New python executable in /builds/slave/test-pgo/build/venv/bin/python 05:10:15 INFO - Installing distribute.............................................................................................................................................................................................done. 05:10:17 INFO - Installing pip.................done. 05:10:17 INFO - Return code: 0 05:10:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test-pgo/build/venv 05:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:17 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 0x7f0fe3ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, '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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 05:10:17 INFO - 'HOME': '/home/cltbld', 05:10:17 INFO - 'LANG': 'en_US.UTF-8', 05:10:17 INFO - 'LANGUAGE': 'en_US:en', 05:10:17 INFO - 'LOGNAME': 'cltbld', 05:10:17 INFO - 'MAIL': '/var/mail/cltbld', 05:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:17 INFO - 'MOZ_NO_REMOTE': '1', 05:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:17 INFO - 'NO_EM_RESTART': '1', 05:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:17 INFO - 'SHELL': '/bin/bash', 05:10:17 INFO - 'SHLVL': '1', 05:10:17 INFO - 'TERM': 'linux', 05:10:17 INFO - 'TMOUT': '86400', 05:10:17 INFO - 'USER': 'cltbld', 05:10:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 05:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:17 INFO - '_': '/tools/buildbot/bin/python'} 05:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:17 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:17 INFO - Cleaning up... 05:10:17 INFO - Return code: 0 05:10:17 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test-pgo/build/venv 05:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:17 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 0x7f0fe3ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, '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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 05:10:17 INFO - 'HOME': '/home/cltbld', 05:10:17 INFO - 'LANG': 'en_US.UTF-8', 05:10:17 INFO - 'LANGUAGE': 'en_US:en', 05:10:17 INFO - 'LOGNAME': 'cltbld', 05:10:17 INFO - 'MAIL': '/var/mail/cltbld', 05:10:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:17 INFO - 'MOZ_NO_REMOTE': '1', 05:10:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:17 INFO - 'NO_EM_RESTART': '1', 05:10:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:17 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:17 INFO - 'SHELL': '/bin/bash', 05:10:17 INFO - 'SHLVL': '1', 05:10:17 INFO - 'TERM': 'linux', 05:10:17 INFO - 'TMOUT': '86400', 05:10:17 INFO - 'USER': 'cltbld', 05:10:17 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 05:10:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:17 INFO - '_': '/tools/buildbot/bin/python'} 05:10:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:17 INFO - Downloading/unpacking psutil>=0.7.1 05:10:17 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:17 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:17 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:17 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:17 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:17 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:19 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/psutil/setup.py) egg_info for package psutil 05:10:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:19 INFO - Installing collected packages: psutil 05:10:19 INFO - Running setup.py install for psutil 05:10:19 INFO - building 'psutil._psutil_linux' extension 05:10:19 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:19 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:19 INFO - building 'psutil._psutil_posix' extension 05:10:19 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:19 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:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:10:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:10:20 INFO - Successfully installed psutil 05:10:20 INFO - Cleaning up... 05:10:20 INFO - Return code: 0 05:10:20 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x7f0fe3ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, '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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', '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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 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 mozsystemmonitor==0.0.0 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 - Downloading mozsystemmonitor-0.0.tar.gz 05:10:22 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:10:22 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:22 INFO - Installing collected packages: mozsystemmonitor 05:10:22 INFO - Running setup.py install for mozsystemmonitor 05:10:22 INFO - Successfully installed mozsystemmonitor 05:10:22 INFO - Cleaning up... 05:10:22 INFO - Return code: 0 05:10:22 INFO - Installing blobuploader==1.2.4 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', '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 0x7f0fe3ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, '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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', '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', 'blobuploader==1.2.4'] 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 blobuploader==1.2.4 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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 05:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:22 INFO - '_': '/tools/buildbot/bin/python'} 05:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:22 INFO - Downloading/unpacking blobuploader==1.2.4 05:10:22 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:22 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 - 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:22 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:22 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:22 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 blobuploader-1.2.4.tar.gz 05:10:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:10:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:24 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/requests/setup.py) egg_info for package requests 05:10:24 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:25 INFO - Downloading docopt-0.6.1.tar.gz 05:10:25 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/docopt/setup.py) egg_info for package docopt 05:10:25 INFO - Installing collected packages: blobuploader, requests, docopt 05:10:25 INFO - Running setup.py install for blobuploader 05:10:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:10:25 INFO - changing mode of /builds/slave/test-pgo/build/venv/bin/blobberc.py to 775 05:10:25 INFO - Running setup.py install for requests 05:10:25 INFO - Running setup.py install for docopt 05:10:25 INFO - Successfully installed blobuploader requests docopt 05:10:25 INFO - Cleaning up... 05:10:25 INFO - Return code: 0 05:10:25 INFO - Installing None 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', '--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 0x7f0fe3ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, '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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', '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', '--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:25 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: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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 05:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:25 INFO - '_': '/tools/buildbot/bin/python'} 05:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:26 INFO - Running setup.py (path:/tmp/pip-TBqc3y-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:26 INFO - Running setup.py (path:/tmp/pip-HSC7XY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:26 INFO - Running setup.py (path:/tmp/pip-HScTwR-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:26 INFO - Running setup.py (path:/tmp/pip-i7kvLE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:26 INFO - Running setup.py (path:/tmp/pip-djk3SJ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:26 INFO - Running setup.py (path:/tmp/pip-bp5TeD-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:26 INFO - Running setup.py (path:/tmp/pip-cnGcjO-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:26 INFO - Running setup.py (path:/tmp/pip-q0N9Bh-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:26 INFO - Running setup.py (path:/tmp/pip-Oyv9Iy-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:26 INFO - Running setup.py (path:/tmp/pip-luclHE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:26 INFO - Running setup.py (path:/tmp/pip-WnaxDV-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:26 INFO - Running setup.py (path:/tmp/pip-o7n3Tv-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:26 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:26 INFO - Running setup.py (path:/tmp/pip-Vy4hq5-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:27 INFO - Running setup.py (path:/tmp/pip-KbHR_o-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:27 INFO - Running setup.py (path:/tmp/pip-KZmokj-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:27 INFO - Running setup.py (path:/tmp/pip-q9J8bF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:27 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:27 INFO - Running setup.py (path:/tmp/pip-lkx9mK-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:27 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:10:27 INFO - Running setup.py install for manifestparser 05:10:27 INFO - Installing manifestparser script to /builds/slave/test-pgo/build/venv/bin 05:10:27 INFO - Running setup.py install for mozcrash 05:10:27 INFO - Running setup.py install for mozdebug 05:10:27 INFO - Running setup.py install for mozdevice 05:10:27 INFO - Installing sutini script to /builds/slave/test-pgo/build/venv/bin 05:10:27 INFO - Installing dm script to /builds/slave/test-pgo/build/venv/bin 05:10:27 INFO - Running setup.py install for mozfile 05:10:27 INFO - Running setup.py install for mozhttpd 05:10:27 INFO - Installing mozhttpd script to /builds/slave/test-pgo/build/venv/bin 05:10:27 INFO - Running setup.py install for mozinfo 05:10:27 INFO - Installing mozinfo script to /builds/slave/test-pgo/build/venv/bin 05:10:27 INFO - Running setup.py install for mozInstall 05:10:28 INFO - Installing moz_remove_from_system script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Installing mozuninstall script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Installing mozinstall script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Installing moz_add_to_system script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Running setup.py install for mozleak 05:10:28 INFO - Running setup.py install for mozlog 05:10:28 INFO - Installing structlog script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Running setup.py install for moznetwork 05:10:28 INFO - Installing moznetwork script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Running setup.py install for mozprocess 05:10:28 INFO - Running setup.py install for mozprofile 05:10:28 INFO - Installing mozprofile script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Installing diff-profiles script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Installing view-profile script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Running setup.py install for mozrunner 05:10:28 INFO - Installing mozrunner script to /builds/slave/test-pgo/build/venv/bin 05:10:28 INFO - Running setup.py install for mozscreenshot 05:10:28 INFO - Running setup.py install for moztest 05:10:28 INFO - Running setup.py install for mozversion 05:10:29 INFO - Installing mozversion script to /builds/slave/test-pgo/build/venv/bin 05:10:29 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:10:29 INFO - Cleaning up... 05:10:29 INFO - Return code: 0 05:10:29 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:29 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 0x7f0fe3ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, '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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', '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:29 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:29 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:29 INFO - Using env: {'DISPLAY': ':0', 05:10:29 INFO - 'HOME': '/home/cltbld', 05:10:29 INFO - 'LANG': 'en_US.UTF-8', 05:10:29 INFO - 'LANGUAGE': 'en_US:en', 05:10:29 INFO - 'LOGNAME': 'cltbld', 05:10:29 INFO - 'MAIL': '/var/mail/cltbld', 05:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:29 INFO - 'MOZ_NO_REMOTE': '1', 05:10:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:29 INFO - 'NO_EM_RESTART': '1', 05:10:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:29 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:29 INFO - 'SHELL': '/bin/bash', 05:10:29 INFO - 'SHLVL': '1', 05:10:29 INFO - 'TERM': 'linux', 05:10:29 INFO - 'TMOUT': '86400', 05:10:29 INFO - 'USER': 'cltbld', 05:10:29 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 05:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:29 INFO - '_': '/tools/buildbot/bin/python'} 05:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:29 INFO - Running setup.py (path:/tmp/pip-WRRnBf-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/manifestparser 05:10:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:29 INFO - Running setup.py (path:/tmp/pip-cokVxY-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozcrash 05:10:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:29 INFO - Running setup.py (path:/tmp/pip-NCYds9-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdebug 05:10:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:29 INFO - Running setup.py (path:/tmp/pip-WmqIDX-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozdevice 05:10:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:29 INFO - Running setup.py (path:/tmp/pip-Eu57xF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozfile 05:10:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:29 INFO - Running setup.py (path:/tmp/pip-zfOMPm-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozhttpd 05:10:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:29 INFO - Running setup.py (path:/tmp/pip-UPsrkE-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinfo 05:10:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:29 INFO - Running setup.py (path:/tmp/pip-OA1SLQ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozinstall 05:10:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:29 INFO - Running setup.py (path:/tmp/pip-N2TitZ-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozleak 05:10:29 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:29 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:29 INFO - Running setup.py (path:/tmp/pip-c5al_v-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozlog 05:10:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:30 INFO - Running setup.py (path:/tmp/pip-tL9Gne-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moznetwork 05:10:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:30 INFO - Running setup.py (path:/tmp/pip-1qD55t-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprocess 05:10:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:30 INFO - Running setup.py (path:/tmp/pip-kVXPuF-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozprofile 05:10:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:30 INFO - Running setup.py (path:/tmp/pip-ZSnzpu-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozrunner 05:10:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:30 INFO - Running setup.py (path:/tmp/pip-NEy9eS-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozscreenshot 05:10:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:30 INFO - Running setup.py (path:/tmp/pip-SlN_0D-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/moztest 05:10:30 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:30 INFO - Unpacking /builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:30 INFO - Running setup.py (path:/tmp/pip-cYtE5b-build/setup.py) egg_info for package from file:///builds/slave/test-pgo/build/tests/mozbase/mozversion 05:10:30 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:30 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:30 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:30 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:30 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:30 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:30 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:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:10:32 INFO - Downloading blessings-1.6.tar.gz 05:10:32 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/blessings/setup.py) egg_info for package blessings 05:10:32 INFO - Installing collected packages: blessings 05:10:32 INFO - Running setup.py install for blessings 05:10:32 INFO - Successfully installed blessings 05:10:32 INFO - Cleaning up... 05:10:32 INFO - Return code: 0 05:10:32 INFO - Done creating virtualenv /builds/slave/test-pgo/build/venv. 05:10:32 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:10:32 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:10:32 INFO - Reading from file tmpfile_stdout 05:10:32 INFO - Current package versions: 05:10:32 INFO - argparse == 1.2.1 05:10:32 INFO - blessings == 1.6 05:10:32 INFO - blobuploader == 1.2.4 05:10:32 INFO - docopt == 0.6.1 05:10:32 INFO - manifestparser == 1.1 05:10:32 INFO - mozInstall == 1.12 05:10:32 INFO - mozcrash == 0.16 05:10:32 INFO - mozdebug == 0.1 05:10:32 INFO - mozdevice == 0.48 05:10:32 INFO - mozfile == 1.2 05:10:32 INFO - mozhttpd == 0.7 05:10:32 INFO - mozinfo == 0.9 05:10:32 INFO - mozleak == 0.1 05:10:32 INFO - mozlog == 3.1 05:10:32 INFO - moznetwork == 0.27 05:10:32 INFO - mozprocess == 0.22 05:10:32 INFO - mozprofile == 0.28 05:10:32 INFO - mozrunner == 6.11 05:10:32 INFO - mozscreenshot == 0.1 05:10:32 INFO - mozsystemmonitor == 0.0 05:10:32 INFO - moztest == 0.7 05:10:32 INFO - mozversion == 1.4 05:10:32 INFO - psutil == 3.1.1 05:10:32 INFO - requests == 1.2.3 05:10:32 INFO - wsgiref == 0.1.2 05:10:32 INFO - Installing None into virtualenv /builds/slave/test-pgo/build/venv 05:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:10:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:32 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 0x7f0fe3ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, '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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 05:10:32 INFO - 'HOME': '/home/cltbld', 05:10:32 INFO - 'LANG': 'en_US.UTF-8', 05:10:32 INFO - 'LANGUAGE': 'en_US:en', 05:10:32 INFO - 'LOGNAME': 'cltbld', 05:10:32 INFO - 'MAIL': '/var/mail/cltbld', 05:10:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:32 INFO - 'MOZ_NO_REMOTE': '1', 05:10:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:32 INFO - 'NO_EM_RESTART': '1', 05:10:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:32 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:32 INFO - 'SHELL': '/bin/bash', 05:10:32 INFO - 'SHLVL': '1', 05:10:32 INFO - 'TERM': 'linux', 05:10:32 INFO - 'TMOUT': '86400', 05:10:32 INFO - 'USER': 'cltbld', 05:10:32 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 05:10:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:32 INFO - '_': '/tools/buildbot/bin/python'} 05:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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:33 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: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 mozhttpd>=0.7->-r /builds/slave/test-pgo/build/tests/talos/requirements.txt (line 4)) 05:10:33 INFO - Cleaning up... 05:10:33 INFO - Return code: 0 05:10:33 INFO - Installing jsonschema into virtualenv /builds/slave/test-pgo/build/venv 05:10:33 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:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:10:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:33 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:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:10:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:10:33 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 0x7f0fe3ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, '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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', '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:33 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:33 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:33 INFO - Using env: {'DISPLAY': ':0', 05:10:33 INFO - 'HOME': '/home/cltbld', 05:10:33 INFO - 'LANG': 'en_US.UTF-8', 05:10:33 INFO - 'LANGUAGE': 'en_US:en', 05:10:33 INFO - 'LOGNAME': 'cltbld', 05:10:33 INFO - 'MAIL': '/var/mail/cltbld', 05:10:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:33 INFO - 'MOZ_NO_REMOTE': '1', 05:10:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:33 INFO - 'NO_EM_RESTART': '1', 05:10:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:10:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:33 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:33 INFO - 'SHELL': '/bin/bash', 05:10:33 INFO - 'SHLVL': '1', 05:10:33 INFO - 'TERM': 'linux', 05:10:33 INFO - 'TMOUT': '86400', 05:10:33 INFO - 'USER': 'cltbld', 05:10:33 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 05:10:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:33 INFO - '_': '/tools/buildbot/bin/python'} 05:10:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:10:33 INFO - Downloading/unpacking jsonschema 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:35 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:10:35 INFO - Downloading/unpacking functools32 (from 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:35 INFO - Downloading functools32-3.2.3-2.tar.gz 05:10:35 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/functools32/setup.py) egg_info for package functools32 05:10:35 INFO - warning: no files found matching '*.txt' 05:10:35 INFO - no previously-included directories found matching 'build' 05:10:35 INFO - no previously-included directories found matching 'dist' 05:10:35 INFO - no previously-included directories found matching '.git*' 05:10:35 INFO - Installing collected packages: jsonschema, functools32 05:10:35 INFO - Running setup.py install for functools32 05:10:35 INFO - warning: no files found matching '*.txt' 05:10:35 INFO - no previously-included directories found matching 'build' 05:10:35 INFO - no previously-included directories found matching 'dist' 05:10:35 INFO - no previously-included directories found matching '.git*' 05:10:35 INFO - Successfully installed jsonschema functools32 05:10:35 INFO - Cleaning up... 05:10:35 INFO - Return code: 0 05:10:35 INFO - Installing flake8 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f0fe3ddff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x158d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x165c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, '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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', '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', 'flake8'] 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 flake8 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': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 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 flake8 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 flake8-2.5.0-py2.py3-none-any.whl 05:10:37 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 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 mccabe-0.3.1-py2.py3-none-any.whl 05:10:37 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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:38 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from 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:38 INFO - Running setup.py (path:/builds/slave/test-pgo/build/venv/build/pep8/setup.py) egg_info for package pep8 05:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:38 INFO - no previously-included directories found matching 'docs/_build' 05:10:38 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:10:38 INFO - Running setup.py install for pep8 05:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:10:38 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:10:38 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:10:38 INFO - no previously-included directories found matching 'docs/_build' 05:10:38 INFO - Installing pep8 script to /builds/slave/test-pgo/build/venv/bin 05:10:38 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:10:38 INFO - Cleaning up... 05:10:38 INFO - Return code: 0 05:10:38 INFO - Running post-action listener: _resource_record_post_action 05:10:38 INFO - Running post-action listener: _start_resource_monitoring 05:10:38 INFO - Starting resource monitoring. 05:10:38 INFO - ##### 05:10:38 INFO - ##### Running install step. 05:10:38 INFO - ##### 05:10:38 INFO - Running pre-action listener: _resource_record_pre_action 05:10:38 INFO - Running main action method: install 05:10:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/pip', 'freeze'] 05:10:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/pip freeze 05:10:38 INFO - Reading from file tmpfile_stdout 05:10:38 INFO - Detecting whether we're running mozinstall >=1.0... 05:10:38 INFO - Getting output from command: ['/builds/slave/test-pgo/build/venv/bin/mozinstall', '-h'] 05:10:38 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/mozinstall -h 05:10:38 INFO - Reading from file tmpfile_stdout 05:10:38 INFO - Output received: 05:10:38 INFO - Usage: mozinstall [options] installer 05:10:38 INFO - Options: 05:10:38 INFO - -h, --help show this help message and exit 05:10:38 INFO - -d DEST, --destination=DEST 05:10:38 INFO - Directory to install application into. [default: 05:10:38 INFO - "/builds/slave/test-pgo"] 05:10:38 INFO - --app=APP Application being installed. [default: firefox] 05:10:38 INFO - mkdir: /builds/slave/test-pgo/build/application 05:10:38 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:38 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:53 INFO - Reading from file tmpfile_stdout 05:10:53 INFO - Output received: 05:10:53 INFO - /builds/slave/test-pgo/build/application/firefox/firefox 05:10:53 INFO - Running post-action listener: _resource_record_post_action 05:10:53 INFO - ##### 05:10:53 INFO - ##### Running run-tests step. 05:10:53 INFO - ##### 05:10:53 INFO - Running pre-action listener: _resource_record_pre_action 05:10:53 INFO - Running main action method: run_tests 05:10:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '--version'] 05:10:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python --version 05:10:53 INFO - Python 2.7.3 05:10:53 INFO - Return code: 0 05:10:53 INFO - grabbing minidump binary from tooltool 05:10:53 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:53 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 0x16ee7f0>, '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 0x165a2d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x165a760>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test-pgo/build', 'privileged': False}, attempt #1 05:10:53 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:53 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:53 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:10:53 INFO - Return code: 0 05:10:53 INFO - Chmoding /builds/slave/test-pgo/build/linux64-minidump_stackwalk to 0755 05:10:53 INFO - mkdir: /builds/slave/test-pgo/build/blobber_upload_dir 05:10:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test-pgo/build/blobber_upload_dir 05:10:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test-pgo/build/linux64-minidump_stackwalk 05:10:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test-pgo/build/blobber_upload_dir 05:10:53 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/flake8', '/builds/slave/test-pgo/build/tests/talos/talos'] 05:10:53 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/flake8 /builds/slave/test-pgo/build/tests/talos/talos 05:10:54 INFO - Return code: 0 05:10:54 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-050', '--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:54 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-050 --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:54 INFO - Using env: {'DISPLAY': ':0', 05:10:54 INFO - 'HOME': '/home/cltbld', 05:10:54 INFO - 'LANG': 'en_US.UTF-8', 05:10:54 INFO - 'LANGUAGE': 'en_US:en', 05:10:54 INFO - 'LOGNAME': 'cltbld', 05:10:54 INFO - 'MAIL': '/var/mail/cltbld', 05:10:54 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:10:54 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test-pgo/build/linux64-minidump_stackwalk', 05:10:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:10:54 INFO - 'MOZ_NO_REMOTE': '1', 05:10:54 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test-pgo/build/blobber_upload_dir', 05:10:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:10:54 INFO - 'NO_EM_RESTART': '1', 05:10:54 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:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test-pgo/buildprops.json', 05:10:54 INFO - 'PWD': '/builds/slave/test-pgo', 05:10:54 INFO - 'PYTHONPATH': '/builds/slave/test-pgo/build/tests/talos', 05:10:54 INFO - 'SHELL': '/bin/bash', 05:10:54 INFO - 'SHLVL': '1', 05:10:54 INFO - 'TERM': 'linux', 05:10:54 INFO - 'TMOUT': '86400', 05:10:54 INFO - 'USER': 'cltbld', 05:10:54 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181', 05:10:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:10:54 INFO - '_': '/tools/buildbot/bin/python'} 05:10:54 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-050', '--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:55 INFO - mozversion application_buildid: 20160225002727 05:10:55 INFO - mozversion application_changeset: b131aaab8f2f65db173486af71fe969c5ceff6da 05:10:55 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:10:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:10:55 INFO - mozversion application_name: Firefox 05:10:55 INFO - mozversion application_remotingname: firefox-dev 05:10:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:10:55 INFO - mozversion application_vendor: Mozilla 05:10:55 INFO - mozversion application_version: 46.0a2 05:10:55 INFO - mozversion platform_buildid: 20160225002727 05:10:55 INFO - mozversion platform_changeset: b131aaab8f2f65db173486af71fe969c5ceff6da 05:10:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:10:55 INFO - mozversion platform_version: 46.0a2 05:10:55 INFO - using testdate: 1456578655 05:10:55 INFO - actual date: 1456578655 05:10:55 INFO - starting webserver on 'localhost:60286' 05:10:55 INFO - SUITE-START | Running 3 tests 05:10:55 INFO - TEST-START | dromaeo_css 05:10:55 INFO - operating with platform_type : linux_ 05:10:55 INFO - Initialising browser for dromaeo_css test... 05:10:55 INFO - TEST-INFO | started process 25217 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMEkTl0/profile http://localhost:60286/getInfo.html) 05:10:58 INFO - PROCESS | 25217 | 05:10:58 INFO - PROCESS | 25217 | (process:25298): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:10:59 INFO - PROCESS | 25217 | __metrics Screen width/height:1600/1200 05:10:59 INFO - PROCESS | 25217 | colorDepth:24 05:10:59 INFO - PROCESS | 25217 | Browser inner width/height: 1024/697 05:10:59 INFO - PROCESS | 25217 | __metrics 05:11:00 INFO - TEST-INFO | 25217: exit 0 05:11:00 INFO - Browser initialized. 05:11:00 INFO - Running cycle 1/1 for dromaeo_css test... 05:11:00 INFO - TEST-INFO | started process 25348 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpMEkTl0/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:11:01 INFO - PROCESS | 25348 | 05:11:01 INFO - PROCESS | 25348 | (process:25413): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:11:12 INFO - PROCESS | 25348 | RSS: Main: 141348864 05:11:12 INFO - PROCESS | 25348 | 05:12:01 INFO - PROCESS | 25348 | 1456578721701 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:09 INFO - PROCESS | 25348 | Cycle 1(1): loaded http://localhost:60286/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60286/tests/dromaeo/cssquery-ext.html) 05:14:10 INFO - PROCESS | 25348 | RSS: Main: 145743872 05:14:10 INFO - PROCESS | 25348 | 05:17:12 INFO - PROCESS | 25348 | Cycle 1(1): loaded http://localhost:60286/tests/dromaeo/cssquery-ext.html (next: http://localhost:60286/tests/dromaeo/cssquery-jquery.html) 05:17:12 INFO - PROCESS | 25348 | RSS: Main: 143613952 05:17:12 INFO - PROCESS | 25348 | 05:20:14 INFO - PROCESS | 25348 | Cycle 1(1): loaded http://localhost:60286/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60286/tests/dromaeo/cssquery-mootools.html) 05:20:15 INFO - PROCESS | 25348 | RSS: Main: 142348288 05:20:15 INFO - PROCESS | 25348 | 05:23:16 INFO - PROCESS | 25348 | Cycle 1(1): loaded http://localhost:60286/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60286/tests/dromaeo/cssquery-prototype.html) 05:23:17 INFO - PROCESS | 25348 | RSS: Main: 143958016 05:23:17 INFO - PROCESS | 25348 | 05:26:19 INFO - PROCESS | 25348 | Cycle 1(1): loaded http://localhost:60286/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60286/tests/dromaeo/cssquery-yui.html) 05:26:20 INFO - PROCESS | 25348 | RSS: Main: 143712256 05:26:20 INFO - PROCESS | 25348 | 05:29:22 INFO - PROCESS | 25348 | Cycle 1(1): loaded http://localhost:60286/tests/dromaeo/cssquery-yui.html (next: http://localhost:60286/tests/dromaeo/cssquery-dojo.html) 05:29:22 INFO - PROCESS | 25348 | RSS: Main: 146890752 05:29:22 INFO - PROCESS | 25348 | 05:29:22 INFO - PROCESS | 25348 | __start_tp_report 05:29:22 INFO - PROCESS | 25348 | _x_x_mozilla_page_load 05:29:22 INFO - PROCESS | 25348 | _x_x_mozilla_page_load_details 05:29:22 INFO - PROCESS | 25348 | |i|pagename|runs| 05:29:22 INFO - PROCESS | 25348 | |0;dojo.html;3327.8668853245867;3338.3990881641294;3355.4631258998565;3367.7979321240728;3383.4417321141996;5400.945990540094;5417;5420.783168673253;5431.076716958117;5447.428020057896;5412.051671354261;5439.755211015504;5453.318335208099;5453.863653408666;5474.91787623186;4870.196417591102;4920.237363208708;5009;5055.646104772667;5061.493850614946;4802.951970480303;4959.752012399384;4992.475790042048;5002.824336280989;5027.170516864713;4993.500649935014;5021.17150670139;5051.898962020758;5056;5076.44159142494;5007.649464537484;5022.0709168803705;5025.447200807908;5035.295058691786;5054.1660625996665;4808.879778005543;4893.779779909913;4905.4358748744;4941.234108713155;4976.975115124401;5212.4266330703595;5216.530512253916;5233.869153271161;5241.42344342122;5253.395859476171;5813.128030795372;5837.737301821428;5839.036558967765;5859.648421094706;5863.442972917566;5680.403557626431;5827.067669172954;5829.737661805187;5829.795957141522;5932.317783454915;5524.696141712204;5559.388467268597;5559.8888022239735;5576.749046292967;5601.439856014406;5916.556258280646;5930.436608522184;5941.494972927263;5942.227510423617;5946.07835785454;5545.473180047969;5589.273394458775;5651.576131790132;5713.085906254979;5716.599838011382;5848;5849.298084229835;5850.502707269845;5852.970735146297;5857.736401861926;5815.214945982323;5815.360310365856;5820.592558520862;5825.679587622722;5841.912371314434;5670.5180059695385;5768.913466298009;5772.278465191851;5799.797007104731;5862.325832529228;4474.821007159742;4475.507694153641;4513.11994161142;4522.3668686383935;4528.750918699503;4045.554988951213;4055.5944405559208;4060.26915155269;4079.938800917989;4089.5501494835544;5392;5474.042042642522;5596.720163991784;5609;5668.319801623831;5803.274590676166;5810.970945145332;5847.590668653239;5861.208736820475;5861.853453663693;5381.165919282517;5517.751701173457;5528.889422211533;5535.501804837503;5541.556675465953;5034.521720436553;5073.695578265316;5092.134337162691;5124.180131178993;5131.332926719577;5925;5967.910481342783;5993.280806303272;6019.789307374309;6033.18551995475;5747.080467125407;5829;5830;5832.9708351457975;5835.649861008353;5979.461848433488;6012.308584512837;6013.819585412444;6070.3929607038945;6103.176071230327;5674.035413979551;5724.141378793214;5806.970965145148;5834.15404766298;5839.795607153729;5719.542436605145;5845.590808643524;5846.41535846412;5855.8536036597725;5903.203067585992;5774.220480235283;5786.450287222707;5792.3917988612275;5800.535957123504;5812.418758124323;5745.540356771365;5746.281714785652;5761.5390768739235;5765.654060756368;5767.913481297868;5528.308961379827;5584.301962254718;5609.49514543693;5672.2058911751565;5698.1737648041635;5654.943450565442;5698.458646428583;5715.971420143039;5722.885542289047;5747.3103227612955;5579.442055794388;5600.719964001865;5631.070873306023;5639.464250896158;5658.094704847369 05:29:22 INFO - PROCESS | 25348 | |1;ext.html;506.3088883673784;515.2734644151747;517.6195496310212;519.3819354967586;538.7117891927818;29845.403091938177;36880.44679329812;37011.4448283276;37061.81469092654;37169.07077323065;40977.795111024476;41832.581674183246;41849.37225941613;41914;42075.158496830045;8690.435121717084;8903.24322432594;8932.910670893305;8953.820923581558;8980.775480613005;8588.8711669325;8723.084076172006;8747.562621868912;8752.781180470476;8963.103689631018;8949.149830766068;8988.505632190227;9004.919409670849;9005.009448960609;9040.547972601344;8884.067172946876;8907.109289071106;8971.416857904216;8971.865422018675;8977.910220897773;8868.955655221747;8891.911080889238;8909.109089091038;8913.286937045086;8992.505412202327;41669.1666166678;41873.581264187276;41975.580244197474;41984.1603167938;42001.57998420007;3422.2299982503987;3511.9122021949656;3599.892003239907;3781.6974642028845;3951.7826519541413;30694.232644183852;30894.22764430885;31275.218119546968;31490.685093149234;31893;4281.620385625427;4335.978320108411;4370.912581748379;4406.515283318832;4437.334399840018;280066.5996670024;280209;280655;281268;281379;58130.709346453;58898.41101589015;62661.68669156716;63815.36184638187;63862.680686597196;56636.716816415654;56915.430845691844;56928.43071569231;57026.714866425405;57147;16952.067636280124;17011.40460083916;17042.31830726782;17072.743908841378;17084.145792710315;14195.64510887236;14240.359183836752;14265.857341426452;14300.213488258038;14392.784108238386;20651.8967405162;20886.791132088787;20942.267020654508;21057.26299579538;21073.473163171042;8085.312748416451;8322.916770832335;8333.874991875127;8346.540940248224;8373.581320933929;973.6835528453281;1046.6755305855208;1071.4589132488043;1121.5233525751687;1148.0012389221265;29468.852655736584;29855.850720746257;29926.55110173349;30262.09213723592;30298.24254393658;1100.9779804404027;1139.1285666464996;1144.3420033480782;1149.3391300002531;1218.750156217991;14115.71768564623;14197.219152946687;14264.072835265675;14294.785578216335;14400.567982960529;321358;487531;488070;489991;693590;54826;55713;55746.72126639341;56103;56175;1443.314425647809;1448.7537118689847;1461.5469204546625;1462.3565631122271;1477.9801936663669;31033.68966310308;32158.839205803823;32279.838600806845;32687.34625307528;32759.0172294822;52802.207966881295;53530.464695352544;53533.99999999844;53848.19227711509;53892.46107539031;308344;311796;311858;311958;312202;45002;45162.32256516089;45450.772746136056;45667;45918.770406147756;47116.7644161777;47764.2835357463;47886;48407.757961209965;48497;40861.591384085776;41455.7927210362;42370.26836898081;42524;42909.785451072545;41059;41103.58896411117;41475;41569.58430415657;42035;41070.58929410668;41085.58914410818;41155.1768964625;41291;41880.162396751286;30975.380492390475;31808.36383272368;31836.5224521637;31948.68051319457;32098.83950580232;27776.722232778222;27811.304717382227;27824;27946;28662.14013579596 05:29:22 INFO - PROCESS | 25348 | |2;jquery.html;385.4622801192337;386.3605732512693;387.81191122305677;389.3808843938138;395.5154935204373;14030.368633411495;15900.92049539752;16587.66824663506;18282.54293642658;18408.171632276546;15982.520524384257;15999.92000040001;16391.508254752345;16822.57943551412;16826.579335516617;5284.365876094865;5395.541378982772;5409.756560954766;5453.863653408676;5458.808941687042;5265.131253343194;5337.67973921564;5460.153676180179;5483.533899618537;5504.697241651707;5196.532312091911;5403.972980135094;5416.620836541424;5459.153831156157;5487.533559647435;5391.460853914597;5417.4853388927795;5446.591505637073;5820.621659592113;6098.969505152446;5441.619086663935;5447.918281225785;5459.972700136474;5485.286912701363;5488.094464413367;16830.663386732198;20469.8976505118;20678.483037924023;20832.79167208339;21319.040643171094;2174.1738139507042;2174.662927246279;2191.802737753594;2246.7753224677563;2403.3510952042852;9296.860547091732;9336.673216437392;9415.058494150599;9469.90530094704;10859.565617375296;1885.8868467891832;1903.8857668539792;1913.1868955693913;1916.32928475034;1944.562473443478;55050.9999999996;60091.39908600946;60337.39662603362;61819;62323;10223.591056357662;10490.685279441628;10494.790104197873;10574.154067674568;10667.679969600924;13706.246156461291;13726.313684315945;13756.243406612532;13827.377768000464;13847.376868040963;7802.180771019075;7885.645145968445;7901.367890568741;8185.631646575918;8234.217749313806;7759.379249660014;7776.339011184;7841.529508229411;7889;8269.917300827035;4501.324801279834;4695.694779839299;4737.549932756383;4752.310914917318;4811.4707382187935;1893.6023435078787;1965.3710812540137;1966.5771859050374;1987.224982256921;1993.9302124425576;974.3423189347162;987.6345752071779;1027.091024443373;1117.932924024561;1127.6278827986744;14775.187364695044;15304.311305991258;16509.66980660404;16932;17934.820651793314;1025.7435641089728;1028.4908970059869;1051.1208986984648;1067.514281002142;1081.1566977757361;9967.651132210338;10019.849702254473;10040.548175332127;10061.647842325483;10072.74818129538;532763;541277;553828;555398;555698;75275;75772;77317.61341193259;77459;77637.22362776414;1157.988420115805;1165.2658824940233;1166.9241499302518;1187.1867770577182;1187.5249900040053;15557.144357060017;15566.599006089506;15717.607059823138;15733.685326293182;15908.284127214534;34611;35077.824610876785;35132;35434.645653543135;35470.290594187456;44577;45022.324665129396;45324.546754532035;45853.31220031635;46209;7229.385502232369;7291.598962057138;7380.520266182681;7499.88750168737;7595.924040759522;11071.391073491035;11381.374024428405;11622.70943226426;11914.10644201671;12077.154599177973;10075.34510256831;10260.435676037889;10609;10657.360558366523;10702.304350217211;10144.74638134023;10392;10444.791104178026;10731.946340268249;10989.120870330195;3369.9326013480086;6113.052476866093;7073.6816843243205;10420.977916404157;10757.569697212024;7728.922710773045;7739.380849532136;7742.264484873928;7750.844983100419;8038;10998.36366538931;11108;11127.276727012719;11166.553337866395;11338.319700817978 05:29:22 INFO - PROCESS | 25348 | |3;mootools.html;1502.541724773944;1532.210911380639;1704.2075434922758;1818.6362727454496;1855.5732181598232;7638.656260468279;7859.331956783681;7872.448928575002;7925.405594580415;8179.059408168063;8326.66693332266;8327.500349979005;8385.287250583708;8423.284020858235;8450.661973521068;2409.6506006629074;2420.636904464327;2423.7939775119135;2438.036975394718;2447.400386905211;2443.743406942272;2464.100603279799;2467.3954881054165;2472.5425796227664;2478.293686299405;2391.198948352304;2446.559619268531;2446.6207737800582;2449.963250551243;2460.052879641342;2374.8693821839793;2399.556082124795;2410.0600765701392;2413.879306034691;2421.0678888628004;2352.5765362234793;2366.171839856054;2366.2664573981947;2367.7277113132036;2368.4789346343778;7837.216278372174;7899.526028438255;7922.405819563556;7990.840183196362;7998.960005199995;4990.326305948687;5079;5093.134167191549;5118.923216151761;5124.615653825978;3260.934781304384;3313.933721325584;3343.5319055332275;3349.8492567834505;3368.360011597789;1073.280901795791;1075.3547871277249;1098.4343063322394;1116.7598966222301;1127.7575321305958;11186.888131118665;11282.266652667633;11312.208145429824;11317.603883864025;11360.204785665006;4464.464264288306;4531.184386810406;4536.750478723636;4573.611243044378;4578.084383123389;9661.372010819274;9681.854772178423;9705.12653861156;9715.46564938935;9744.951275243578;5071.87320316995;5091.032703786269;5091.1854103343285;5112.9744351278005;5114.514121158484;4582.289745089516;4593;4594.471635761864;4597.3333866589155;4612.400387949612;3820.84716611338;3831.8658846940225;3863.478430411915;3867.613238676166;3896.162325100117;1202.296656455983;1212;1215.5623975369037;1220.5850010996303;1236.863944966053;1083.2146693647044;1133.5125895864858;1217.1966502108567;1302.7785276503016;1365.863413658646;7252.927470725225;7268.781936541912;7390.704371825174;7409.592472413961;7430.034095567542;616.7532986805224;625.293418437163;627.1063734178776;635.2377147423018;785.952842829432;5756.33802112754;5760.279965004374;5796.884062318814;5811.622244554091;5877.206577112035;9351.438913665066;9755.951220243853;9785.168260697921;9934.105930466148;10093.192544596415;9612.855807162898;9782;9911.405315680939;9966.501674916226;9975.401475911323;7432.814179645552;7560.659770310349;7585.393168546503;7594.886076708854;7621.199774023758;7192.892106618509;7384.593847338448;7391.926080739124;7409.8147546311775;7429.591372474566;8601.65593376283;8709.651613935372;8898.243649289883;9056.460401731852;9091.136342047495;9028.18746312835;9081.591328390106;9093.454392736458;9120.087991201091;9139.405938613969;7186.281371862772;7274.4907856451655;7285;7320.341169294789;7321.414286857145;7769.72805951789;7775.261350171724;7848.450608457581;7856.175101614248;7874.56689882062;7196.388306993755;7403.629818508945;7416.44376671741;7457.291557302047;7740.26467485588;7008.7546935857;7077;7128.607926564089;7184.317489838457;7282.890756638549;7357;7419.07261592301;7431.554106753612;7456.96271518639;7466.402687785073;6631.933680663132;6660.966695166493;6662.400383965466;6701.698423570853;6734.4275736560985;6686.231083425274;6712.664366781739;6761.154855643044;6886.414654754402;6887.242403335729 05:29:22 INFO - PROCESS | 25348 | |4;prototype.html;352.3956414748706;361.9674229319361;362.5160410851513;365.7330148991238;365.90669379308275;6284.685765711708;6332.905006424908;6424.132742079818;6432.839179020515;6448.226212854464;6195.721192546335;6345.333739957296;6376.202974628171;6395.968020159904;6398.040293955897;4842.830500932468;4877.926831097528;4889.608831293505;4892.926606100911;4894.632902532307;4883.243097319921;4902.5342592453835;4904.435989861176;4909.7545122743895;4915.262710593403;4687.624990000809;4823.469418363995;4826.734529600871;4841.951580484185;4843.321934929095;4815.807367705288;4824.493428190042;4828.589569886564;4829.058333624945;4837.395325584302;4208.305629571148;4208.957910420918;4215.325547912319;4221.746695198267;4235;5889.8822023559715;6014.12795144706;6047.092936059582;6063.939360606426;6069.817905462844;5618.8033418830555;5640.069388550925;5653.802116925888;5655.915161272543;5666.376698563155;6680.565763225423;6681.53229273951;6705.731770729165;6709.731610735565;6732.091167692348;4610.9077818443775;4680.134175177603;4691.390119284505;4710.670253082286;4712.387389639359;6925.99999999995;7005.719771209146;7095.964520177417;7098.645067746592;7099;4768.117898188846;4793.304970779218;4805.927911081267;4821.2045012572535;4830.589399900978;4840.854774356775;4859.684120532154;4889.535494128123;4897.1674815281485;4899.8285060023445;5471.015217260851;5602.943970560324;5641.787015791624;5654.575906807006;5660.830175094754;6766.052752614638;6794.524383293122;6800.251972283045;6816.182058152955;6830.556013859084;1676.9161541922856;1716.828317168298;1721.3544920654754;1728.1877517566975;1731.809500954894;1136.4545018391218;1163.8312444695641;1168.8480497535265;1177.5937301630925;1183.3728124094243;6409.903851442232;6412.903806442907;6424.903626445607;6431;6464.353564643498;6894.24163342032;6903.930960690429;6907.930920690829;6909.239983601799;6910.30896910315;6412.422881940648;6417.005364168468;6418.293987661354;6431.742730290736;6443.194600674916;3771.86798462058;3784.905377365588;3786.886393408147;3793.5827059023486;3795.259924314732;7201.3158749918675;7216.206217316091;7242.746503872339;7294;7307.671154798047;7100.254473280334;7166.641667916583;7170.641467926583;7236.204017558064;7250.963745181346;7276.927230727731;7281.1262648482525;7298.598577078312;7303.415726741848;7304.488685791944;7025.578465291895;7026.718931242693;7035.718571257093;7069.858602828018;7081.4334853210585;6771.695273712793;6893.138357705287;6934.757283495255;6955.617441040791;7000.404965577983;7270.163931147986;7278.927210727825;7311.41508679315;7313.268673132857;7336.229695881855;4842.225243960949;4846.975765121152;4851.660383773243;4862.367892173995;4869.050535145612;6875.7937261882225;6907.827304317432;7016.543924644881;7074.646267686698;7086.964565177141;6760.93239067603;6837.829054273683;6858.348456896587;6885.758998435031;6900.447964162955;6836.418904393182;6852.554583952027;6861.759838405632;6869.622170780655;6873.725050997904;6625.50926041656;6713.563618364986;6759.662016899037;6779.762678316045;6801.217859945971;6859.348361905611;6893.379595836399;6911.101556797584;6913.582715543201;6929.1684997800585;6657.201135863727;6677.098591690254;6680.265170831108;6686.69909854048;6687.732490700512 05:29:22 INFO - PROCESS | 25348 | |5;yui.html;730.408369220931;743.1565173528047;785.9607019649017;798.2576204130161;905.551751882818;13267.601971940845;13361.198328100321;13527.864721352784;13550.932245338785;13559.11865728727;13347.866521334783;13408.26254555999;13551.25468099254;13568.118072325293;15351.769723454157;854.7179430787857;864.6282098697558;869.2784988459564;869.5391442535466;870.4733636150102;877.403365711316;879.0155026370473;882.4572887674067;887.2990337633262;887.4409122252972;904.5658084119626;910.6175406329324;914.1315750037458;917.0691747875911;918.3846822628822;908.3505293714959;909.4497828813605;910.8087301666658;913.0914739833842;915.6612053540166;661.0678942690831;672.3041651890319;673.3603077076797;675.0717763075771;676.1345477788439;14291.714165716732;14370.425182992667;14374.20941848198;14383.856161438356;14425;12881.67795805103;12882.291473968928;13023.088383813138;13204.735905281937;13211.537596184184;11160.441977901073;11623;11633.185677002613;11746.236494627821;11831.349275789828;3862.208247309295;3892.299386110499;3902.9804850975847;3924.4701965234613;3936.8425262989444;49420.75289623529;49463;49984.50015499835;50239.74880125612;51888.74055629735;10789;10895.891041089488;11166.441677916235;11187.440627968732;11269.267497612629;18175.272989080553;18335.44993650166;18380.264789408542;18409.723854142198;18458.723119153223;8182.918170818335;8345.165483451729;8413.74758757226;8414.326853851677;8430.662773488992;4418.182636212311;4559.270516717309;4570.415768432252;4600.01487394337;4604.621455555519;3104.8758049678213;3117.8908738194054;3128.5307203919137;3144.261098641817;3149.4488464519077;583.0816464069109;640.4396153365805;641.8748344072861;645.5061877663591;654.0516251435438;731.1737736357987;733.4999925153074;775.7789030126387;778.4628606261662;787.9960600196962;8681.826363472695;9792.608295668093;9792.706218813448;9861.408315501092;9939.950300248596;648.24803228255;661.599732162035;760.6957217113088;776.6543887969799;778.2140038560981;4217.430646862635;4258.510271318776;4288.785560721952;4331.350297455407;4479.372887795711;57884.71057644685;58105.70947145237;58370;58481.70759146177;58945.705271474224;46803;53619.92760144775;54018;54411.45588544143;54604.45395546073;48479;49112.75443622759;49473.50526494761;50008.49991500111;50056.24915626268;9342.626294948397;9475.952620236854;9507.096825801538;9596.520173991412;9691.07934746198;36370.8181459091;36938.44592331063;37149.071273217305;37474.8126259367;37577.248455031295;44076.55923440853;45252;48465.27302090401;48579.5142048575;48913.51086489089;11793.52825886955;12123.272603643809;12147.757044858876;12193.268403895794;12309.384530773246;13144.802827957397;13496.595102146952;13927.791083133963;13987.510437134652;14520.491782787552;12521.749565008831;12579.811302830281;12769.87230127724;12943.482260709467;13661.726765464833;12516.749665006831;12544.372781360713;13117.08180427399;13333.799993000306;13465.932670336586;12760.6809829755;12865.485380584672;12872.613821585368;13276.86723132795;13427.12723672958;9898.653547125816;10279.845802312822;10313.845292320471;10329.225308101772;10403.063724264852;10595.629152979609;10900.7274818127;11073.16951228645;11121.721956950818;11265.380404077854 05:29:22 INFO - PROCESS | 25348 | __end_tp_report 05:29:22 INFO - PROCESS | 25348 | __start_cc_report 05:29:22 INFO - PROCESS | 25348 | _x_x_mozilla_cycle_collect,300 05:29:22 INFO - PROCESS | 25348 | __end_cc_report 05:29:22 INFO - PROCESS | 25348 | __startTimestamp1456579762796__endTimestamp 05:29:22 INFO - PROCESS | 25348 | 05:29:22 INFO - PROCESS | 25348 | ------- Summary: start ------- 05:29:22 INFO - PROCESS | 25348 | Number of tests: 6 05:29:22 INFO - PROCESS | 25348 | 05:29:22 INFO - PROCESS | 25348 | [#0] dojo.html Cycles:165 Average:5427.88 Median:5639.46 stddev:580.08 (10.3%) stddev-sans-first:557.97 05:29:22 INFO - PROCESS | 25348 | Values: 3327.9 3338.4 3355.5 3367.8 3383.4 5400.9 5417.0 5420.8 5431.1 5447.4 5412.1 5439.8 5453.3 5453.9 5474.9 4870.2 4920.2 5009.0 5055.6 5061.5 4803.0 4959.8 4992.5 5002.8 5027.2 4993.5 5021.2 5051.9 5056.0 5076.4 5007.6 5022.1 5025.4 5035.3 5054.2 4808.9 4893.8 4905.4 4941.2 4977.0 5212.4 5216.5 5233.9 5241.4 5253.4 5813.1 5837.7 5839.0 5859.6 5863.4 5680.4 5827.1 5829.7 5829.8 5932.3 5524.7 5559.4 5559.9 5576.7 5601.4 5916.6 5930.4 5941.5 5942.2 5946.1 5545.5 5589.3 5651.6 5713.1 5716.6 5848.0 5849.3 5850.5 5853.0 5857.7 5815.2 5815.4 5820.6 5825.7 5841.9 5670.5 5768.9 5772.3 5799.8 5862.3 4474.8 4475.5 4513.1 4522.4 4528.8 4045.6 4055.6 4060.3 4079.9 4089.6 5392.0 5474.0 5596.7 5609.0 5668.3 5803.3 5811.0 5847.6 5861.2 5861.9 5381.2 5517.8 5528.9 5535.5 5541.6 5034.5 5073.7 5092.1 5124.2 5131.3 5925.0 5967.9 5993.3 6019.8 6033.2 5747.1 5829.0 5830.0 5833.0 5835.6 5979.5 6012.3 6013.8 6070.4 6103.2 5674.0 5724.1 5807.0 5834.2 5839.8 5719.5 5845.6 5846.4 5855.9 5903.2 5774.2 5786.5 5792.4 5800.5 5812.4 5745.5 5746.3 5761.5 5765.7 5767.9 5528.3 5584.3 5609.5 5672.2 5698.2 5654.9 5698.5 5716.0 5722.9 5747.3 5579.4 5600.7 5631.1 5639.5 5658.1 05:29:22 INFO - PROCESS | 25348 | 05:29:22 INFO - PROCESS | 25348 | [#1] ext.html Cycles:180 Average:53824.98 Median:41619.38 stddev:100986.43 (242.6%) stddev-sans-first:101190.38 05:29:22 INFO - PROCESS | 25348 | Values: 506.3 515.3 517.6 519.4 538.7 29845.4 36880.4 37011.4 37061.8 37169.1 40977.8 41832.6 41849.4 41914.0 42075.2 8690.4 8903.2 8932.9 8953.8 8980.8 8588.9 8723.1 8747.6 8752.8 8963.1 8949.1 8988.5 9004.9 9005.0 9040.5 8884.1 8907.1 8971.4 8971.9 8977.9 8869.0 8891.9 8909.1 8913.3 8992.5 41669.2 41873.6 41975.6 41984.2 42001.6 3422.2 3511.9 3599.9 3781.7 3951.8 30694.2 30894.2 31275.2 31490.7 31893.0 4281.6 4336.0 4370.9 4406.5 4437.3 280066.6 280209.0 280655.0 281268.0 281379.0 58130.7 58898.4 62661.7 63815.4 63862.7 56636.7 56915.4 56928.4 57026.7 57147.0 16952.1 17011.4 17042.3 17072.7 17084.1 14195.6 14240.4 14265.9 14300.2 14392.8 20651.9 20886.8 20942.3 21057.3 21073.5 8085.3 8322.9 8333.9 8346.5 8373.6 973.7 1046.7 1071.5 1121.5 1148.0 29468.9 29855.9 29926.6 30262.1 30298.2 1101.0 1139.1 1144.3 1149.3 1218.8 14115.7 14197.2 14264.1 14294.8 14400.6 321358.0 487531.0 488070.0 489991.0 693590.0 54826.0 55713.0 55746.7 56103.0 56175.0 1443.3 1448.8 1461.5 1462.4 1478.0 31033.7 32158.8 32279.8 32687.3 32759.0 52802.2 53530.5 53534.0 53848.2 53892.5 308344.0 311796.0 311858.0 311958.0 312202.0 45002.0 45162.3 45450.8 45667.0 45918.8 47116.8 47764.3 47886.0 48407.8 48497.0 40861.6 41455.8 42370.3 42524.0 42909.8 41059.0 41103.6 41475.0 41569.6 42035.0 41070.6 41085.6 41155.2 41291.0 41880.2 30975.4 31808.4 31836.5 31948.7 32098.8 27776.7 27811.3 27824.0 27946.0 28662.1 05:29:22 INFO - PROCESS | 25348 | 05:29:22 INFO - PROCESS | 25348 | [#2] jquery.html Cycles:180 Average:28282.66 Median:18990.47 stddev:89548.28 (471.5%) stddev-sans-first:89774.98 05:29:22 INFO - PROCESS | 25348 | Values: 385.5 386.4 387.8 389.4 395.5 14030.4 15900.9 16587.7 18282.5 18408.2 15982.5 15999.9 16391.5 16822.6 16826.6 5284.4 5395.5 5409.8 5453.9 5458.8 5265.1 5337.7 5460.2 5483.5 5504.7 5196.5 5404.0 5416.6 5459.2 5487.5 5391.5 5417.5 5446.6 5820.6 6099.0 5441.6 5447.9 5460.0 5485.3 5488.1 16830.7 20469.9 20678.5 20832.8 21319.0 2174.2 2174.7 2191.8 2246.8 2403.4 9296.9 9336.7 9415.1 9469.9 10859.6 1885.9 1903.9 1913.2 1916.3 1944.6 55051.0 60091.4 60337.4 61819.0 62323.0 10223.6 10490.7 10494.8 10574.2 10667.7 13706.2 13726.3 13756.2 13827.4 13847.4 7802.2 7885.6 7901.4 8185.6 8234.2 7759.4 7776.3 7841.5 7889.0 8269.9 4501.3 4695.7 4737.5 4752.3 4811.5 1893.6 1965.4 1966.6 1987.2 1993.9 974.3 987.6 1027.1 1117.9 1127.6 14775.2 15304.3 16509.7 16932.0 17934.8 1025.7 1028.5 1051.1 1067.5 1081.2 9967.7 10019.8 10040.5 10061.6 10072.7 532763.0 541277.0 553828.0 555398.0 555698.0 75275.0 75772.0 77317.6 77459.0 77637.2 1158.0 1165.3 1166.9 1187.2 1187.5 15557.1 15566.6 15717.6 15733.7 15908.3 34611.0 35077.8 35132.0 35434.6 35470.3 44577.0 45022.3 45324.5 45853.3 46209.0 7229.4 7291.6 7380.5 7499.9 7595.9 11071.4 11381.4 11622.7 11914.1 12077.2 10075.3 10260.4 10609.0 10657.4 10702.3 10144.7 10392.0 10444.8 10731.9 10989.1 3369.9 6113.1 7073.7 10421.0 10757.6 7728.9 7739.4 7742.3 7750.8 8038.0 10998.4 11108.0 11127.3 11166.6 11338.3 05:29:22 INFO - PROCESS | 25348 | 05:29:22 INFO - PROCESS | 25348 | [#3] mootools.html Cycles:180 Average:5719.82 Median:6646.45 stddev:2967.28 (44.6%) stddev-sans-first:2958.67 05:29:22 INFO - PROCESS | 25348 | Values: 1502.5 1532.2 1704.2 1818.6 1855.6 7638.7 7859.3 7872.4 7925.4 8179.1 8326.7 8327.5 8385.3 8423.3 8450.7 2409.7 2420.6 2423.8 2438.0 2447.4 2443.7 2464.1 2467.4 2472.5 2478.3 2391.2 2446.6 2446.6 2450.0 2460.1 2374.9 2399.6 2410.1 2413.9 2421.1 2352.6 2366.2 2366.3 2367.7 2368.5 7837.2 7899.5 7922.4 7990.8 7999.0 4990.3 5079.0 5093.1 5118.9 5124.6 3260.9 3313.9 3343.5 3349.8 3368.4 1073.3 1075.4 1098.4 1116.8 1127.8 11186.9 11282.3 11312.2 11317.6 11360.2 4464.5 4531.2 4536.8 4573.6 4578.1 9661.4 9681.9 9705.1 9715.5 9745.0 5071.9 5091.0 5091.2 5113.0 5114.5 4582.3 4593.0 4594.5 4597.3 4612.4 3820.8 3831.9 3863.5 3867.6 3896.2 1202.3 1212.0 1215.6 1220.6 1236.9 1083.2 1133.5 1217.2 1302.8 1365.9 7252.9 7268.8 7390.7 7409.6 7430.0 616.8 625.3 627.1 635.2 786.0 5756.3 5760.3 5796.9 5811.6 5877.2 9351.4 9756.0 9785.2 9934.1 10093.2 9612.9 9782.0 9911.4 9966.5 9975.4 7432.8 7560.7 7585.4 7594.9 7621.2 7192.9 7384.6 7391.9 7409.8 7429.6 8601.7 8709.7 8898.2 9056.5 9091.1 9028.2 9081.6 9093.5 9120.1 9139.4 7186.3 7274.5 7285.0 7320.3 7321.4 7769.7 7775.3 7848.5 7856.2 7874.6 7196.4 7403.6 7416.4 7457.3 7740.3 7008.8 7077.0 7128.6 7184.3 7282.9 7357.0 7419.1 7431.6 7457.0 7466.4 6631.9 6661.0 6662.4 6701.7 6734.4 6686.2 6712.7 6761.2 6886.4 6887.2 05:29:22 INFO - PROCESS | 25348 | 05:29:22 INFO - PROCESS | 25348 | [#4] prototype.html Cycles:180 Average:5671.89 Median:6417.65 stddev:1714.74 (26.7%) stddev-sans-first:1672.42 05:29:22 INFO - PROCESS | 25348 | Values: 352.4 362.0 362.5 365.7 365.9 6284.7 6332.9 6424.1 6432.8 6448.2 6195.7 6345.3 6376.2 6396.0 6398.0 4842.8 4877.9 4889.6 4892.9 4894.6 4883.2 4902.5 4904.4 4909.8 4915.3 4687.6 4823.5 4826.7 4842.0 4843.3 4815.8 4824.5 4828.6 4829.1 4837.4 4208.3 4209.0 4215.3 4221.7 4235.0 5889.9 6014.1 6047.1 6063.9 6069.8 5618.8 5640.1 5653.8 5655.9 5666.4 6680.6 6681.5 6705.7 6709.7 6732.1 4610.9 4680.1 4691.4 4710.7 4712.4 6926.0 7005.7 7096.0 7098.6 7099.0 4768.1 4793.3 4805.9 4821.2 4830.6 4840.9 4859.7 4889.5 4897.2 4899.8 5471.0 5602.9 5641.8 5654.6 5660.8 6766.1 6794.5 6800.3 6816.2 6830.6 1676.9 1716.8 1721.4 1728.2 1731.8 1136.5 1163.8 1168.8 1177.6 1183.4 6409.9 6412.9 6424.9 6431.0 6464.4 6894.2 6903.9 6907.9 6909.2 6910.3 6412.4 6417.0 6418.3 6431.7 6443.2 3771.9 3784.9 3786.9 3793.6 3795.3 7201.3 7216.2 7242.7 7294.0 7307.7 7100.3 7166.6 7170.6 7236.2 7251.0 7276.9 7281.1 7298.6 7303.4 7304.5 7025.6 7026.7 7035.7 7069.9 7081.4 6771.7 6893.1 6934.8 6955.6 7000.4 7270.2 7278.9 7311.4 7313.3 7336.2 4842.2 4847.0 4851.7 4862.4 4869.1 6875.8 6907.8 7016.5 7074.6 7087.0 6760.9 6837.8 6858.3 6885.8 6900.4 6836.4 6852.6 6861.8 6869.6 6873.7 6625.5 6713.6 6759.7 6779.8 6801.2 6859.3 6893.4 6911.1 6913.6 6929.2 6657.2 6677.1 6680.3 6686.7 6687.7 05:29:22 INFO - PROCESS | 25348 | 05:29:22 INFO - PROCESS | 25348 | [#5] yui.html Cycles:180 Average:14644.44 Median:24865.69 stddev:16516.31 (66.4%) stddev-sans-first:16529.58 05:29:22 INFO - PROCESS | 25348 | Values: 730.4 743.2 786.0 798.3 905.6 13267.6 13361.2 13527.9 13550.9 13559.1 13347.9 13408.3 13551.3 13568.1 15351.8 854.7 864.6 869.3 869.5 870.5 877.4 879.0 882.5 887.3 887.4 904.6 910.6 914.1 917.1 918.4 908.4 909.4 910.8 913.1 915.7 661.1 672.3 673.4 675.1 676.1 14291.7 14370.4 14374.2 14383.9 14425.0 12881.7 12882.3 13023.1 13204.7 13211.5 11160.4 11623.0 11633.2 11746.2 11831.3 3862.2 3892.3 3903.0 3924.5 3936.8 49420.8 49463.0 49984.5 50239.7 51888.7 10789.0 10895.9 11166.4 11187.4 11269.3 18175.3 18335.4 18380.3 18409.7 18458.7 8182.9 8345.2 8413.7 8414.3 8430.7 4418.2 4559.3 4570.4 4600.0 4604.6 3104.9 3117.9 3128.5 3144.3 3149.4 583.1 640.4 641.9 645.5 654.1 731.2 733.5 775.8 778.5 788.0 8681.8 9792.6 9792.7 9861.4 9940.0 648.2 661.6 760.7 776.7 778.2 4217.4 4258.5 4288.8 4331.4 4479.4 57884.7 58105.7 58370.0 58481.7 58945.7 46803.0 53619.9 54018.0 54411.5 54604.5 48479.0 49112.8 49473.5 50008.5 50056.2 9342.6 9476.0 9507.1 9596.5 9691.1 36370.8 36938.4 37149.1 37474.8 37577.2 44076.6 45252.0 48465.3 48579.5 48913.5 11793.5 12123.3 12147.8 12193.3 12309.4 13144.8 13496.6 13927.8 13987.5 14520.5 12521.7 12579.8 12769.9 12943.5 13661.7 12516.7 12544.4 13117.1 13333.8 13465.9 12760.7 12865.5 12872.6 13276.9 13427.1 9898.7 10279.8 10313.8 10329.2 10403.1 10595.6 10900.7 11073.2 11121.7 11265.4 05:29:22 INFO - PROCESS | 25348 | -------- Summary: end -------- 05:29:22 INFO - PROCESS | 25348 | 05:29:23 INFO - TEST-INFO | 25348: exit 0 05:29:23 INFO - TEST-OK | dromaeo_css | took 1108205ms 05:29:23 INFO - TEST-START | kraken 05:29:23 INFO - operating with platform_type : linux_ 05:29:23 INFO - Initialising browser for kraken test... 05:29:23 INFO - TEST-INFO | started process 25597 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyJegOA/profile http://localhost:60286/getInfo.html) 05:29:26 INFO - PROCESS | 25597 | 05:29:26 INFO - PROCESS | 25597 | (process:25673): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:27 INFO - PROCESS | 25597 | __metrics Screen width/height:1600/1200 05:29:27 INFO - PROCESS | 25597 | colorDepth:24 05:29:27 INFO - PROCESS | 25597 | Browser inner width/height: 1024/697 05:29:27 INFO - PROCESS | 25597 | __metrics 05:29:28 INFO - TEST-INFO | 25597: exit 0 05:29:28 INFO - Browser initialized. 05:29:28 INFO - Running cycle 1/1 for kraken test... 05:29:28 INFO - TEST-INFO | started process 25722 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpyJegOA/profile -tp file:/builds/slave/test-pgo/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:29:29 INFO - PROCESS | 25722 | 05:29:29 INFO - PROCESS | 25722 | (process:25784): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:29:40 INFO - PROCESS | 25722 | RSS: Main: 141459456 05:29:40 INFO - PROCESS | 25722 | 05:29:42 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60286/tests/kraken/driver.html?testName=audio-beat-detection) 05:29:43 INFO - PROCESS | 25722 | RSS: Main: 146464768 05:29:43 INFO - PROCESS | 25722 | 05:29:46 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60286/tests/kraken/driver.html?testName=audio-dft) 05:29:46 INFO - PROCESS | 25722 | RSS: Main: 145297408 05:29:46 INFO - PROCESS | 25722 | 05:29:49 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60286/tests/kraken/driver.html?testName=audio-fft) 05:29:50 INFO - PROCESS | 25722 | RSS: Main: 145670144 05:29:50 INFO - PROCESS | 25722 | 05:29:52 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60286/tests/kraken/driver.html?testName=audio-oscillator) 05:29:52 INFO - PROCESS | 25722 | RSS: Main: 145596416 05:29:52 INFO - PROCESS | 25722 | 05:29:54 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60286/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:29:55 INFO - PROCESS | 25722 | RSS: Main: 145235968 05:29:55 INFO - PROCESS | 25722 | 05:29:58 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60286/tests/kraken/driver.html?testName=imaging-darkroom) 05:29:59 INFO - PROCESS | 25722 | RSS: Main: 146624512 05:29:59 INFO - PROCESS | 25722 | 05:30:02 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60286/tests/kraken/driver.html?testName=imaging-desaturate) 05:30:03 INFO - PROCESS | 25722 | RSS: Main: 146325504 05:30:03 INFO - PROCESS | 25722 | 05:30:05 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60286/tests/kraken/driver.html?testName=json-parse-financial) 05:30:06 INFO - PROCESS | 25722 | RSS: Main: 146509824 05:30:06 INFO - PROCESS | 25722 | 05:30:07 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60286/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:30:08 INFO - PROCESS | 25722 | RSS: Main: 145715200 05:30:08 INFO - PROCESS | 25722 | 05:30:10 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60286/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:30:10 INFO - PROCESS | 25722 | RSS: Main: 144838656 05:30:10 INFO - PROCESS | 25722 | 05:30:13 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60286/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:30:13 INFO - PROCESS | 25722 | RSS: Main: 147202048 05:30:13 INFO - PROCESS | 25722 | 05:30:15 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:30:16 INFO - PROCESS | 25722 | RSS: Main: 146882560 05:30:16 INFO - PROCESS | 25722 | 05:30:19 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:30:19 INFO - PROCESS | 25722 | RSS: Main: 146186240 05:30:19 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | Cycle 1(1): loaded http://localhost:60286/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60286/tests/kraken/driver.html?testName=ai-astar) 05:30:21 INFO - PROCESS | 25722 | RSS: Main: 146796544 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | __start_tp_report 05:30:21 INFO - PROCESS | 25722 | _x_x_mozilla_page_load 05:30:21 INFO - PROCESS | 25722 | _x_x_mozilla_page_load_details 05:30:21 INFO - PROCESS | 25722 | |i|pagename|runs| 05:30:21 INFO - PROCESS | 25722 | |0;ai-astar;113;105;111;111;112;121;110;114;115;111 05:30:21 INFO - PROCESS | 25722 | |1;audio-beat-detection;149;133;159;167;125;157;153;128;167;126 05:30:21 INFO - PROCESS | 25722 | |2;audio-dft;164;163;161;164;161;165;161;161;163;162 05:30:21 INFO - PROCESS | 25722 | |3;audio-fft;72;75;76;159;74;72;73;73;163;75 05:30:21 INFO - PROCESS | 25722 | |4;audio-oscillator;95;96;142;98;96;96;139;96;95;134 05:30:21 INFO - PROCESS | 25722 | |5;imaging-gaussian-blur;111;110;110;109;109;111;110;110;109;110 05:30:21 INFO - PROCESS | 25722 | |6;imaging-darkroom;147;147;147;147;147;147;146;147;147;148 05:30:21 INFO - PROCESS | 25722 | |7;imaging-desaturate;97;96;96;97;97;97;96;96;96;97 05:30:21 INFO - PROCESS | 25722 | |8;json-parse-financial;55;56;55;56;56;58;55;61;57;63 05:30:21 INFO - PROCESS | 25722 | |9;json-stringify-tinderbox;64;65;64;64;65;65;64;65;65;64 05:30:21 INFO - PROCESS | 25722 | |10;stanford-crypto-aes;88;81;84;82;83;89;82;90;91;83 05:30:21 INFO - PROCESS | 25722 | |11;stanford-crypto-ccm;112;120;111;125;114;118;113;114;121;113 05:30:21 INFO - PROCESS | 25722 | |12;stanford-crypto-pbkdf2;127;131;136;134;136;139;144;137;137;135 05:30:21 INFO - PROCESS | 25722 | |13;stanford-crypto-sha256-iterative;64;68;68;64;65;66;63;65;64;64 05:30:21 INFO - PROCESS | 25722 | __end_tp_report 05:30:21 INFO - PROCESS | 25722 | __start_cc_report 05:30:21 INFO - PROCESS | 25722 | _x_x_mozilla_cycle_collect,743 05:30:21 INFO - PROCESS | 25722 | __end_cc_report 05:30:21 INFO - PROCESS | 25722 | __startTimestamp1456579821507__endTimestamp 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | ------- Summary: start ------- 05:30:21 INFO - PROCESS | 25722 | Number of tests: 14 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.50 stddev:4.08 (3.6%) stddev-sans-first:4.32 05:30:21 INFO - PROCESS | 25722 | Values: 113.0 105.0 111.0 111.0 112.0 121.0 110.0 114.0 115.0 111.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#1] audio-beat-detection Cycles:10 Average:146.40 Median:155.00 stddev:16.87 (10.9%) stddev-sans-first:17.87 05:30:21 INFO - PROCESS | 25722 | Values: 149.0 133.0 159.0 167.0 125.0 157.0 153.0 128.0 167.0 126.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:1.51 (0.9%) stddev-sans-first:1.50 05:30:21 INFO - PROCESS | 25722 | Values: 164.0 163.0 161.0 164.0 161.0 165.0 161.0 161.0 163.0 162.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#3] audio-fft Cycles:10 Average:91.20 Median:73.50 stddev:36.82 (50.1%) stddev-sans-first:38.40 05:30:21 INFO - PROCESS | 25722 | Values: 72.0 75.0 76.0 159.0 74.0 72.0 73.0 73.0 163.0 75.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#4] audio-oscillator Cycles:10 Average:108.70 Median:96.00 stddev:20.55 (21.4%) stddev-sans-first:21.19 05:30:21 INFO - PROCESS | 25722 | Values: 95.0 96.0 142.0 98.0 96.0 96.0 139.0 96.0 95.0 134.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 05:30:21 INFO - PROCESS | 25722 | Values: 111.0 110.0 110.0 109.0 109.0 111.0 110.0 110.0 109.0 110.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 05:30:21 INFO - PROCESS | 25722 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 146.0 147.0 147.0 148.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:97.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:30:21 INFO - PROCESS | 25722 | Values: 97.0 96.0 96.0 97.0 97.0 97.0 96.0 96.0 96.0 97.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#8] json-parse-financial Cycles:10 Average:57.20 Median:56.50 stddev:2.74 (4.9%) stddev-sans-first:2.79 05:30:21 INFO - PROCESS | 25722 | Values: 55.0 56.0 55.0 56.0 56.0 58.0 55.0 61.0 57.0 63.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#9] json-stringify-tinderbox Cycles:10 Average:64.50 Median:65.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 05:30:21 INFO - PROCESS | 25722 | Values: 64.0 65.0 64.0 64.0 65.0 65.0 64.0 65.0 65.0 64.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:86.00 stddev:3.77 (4.4%) stddev-sans-first:3.87 05:30:21 INFO - PROCESS | 25722 | Values: 88.0 81.0 84.0 82.0 83.0 89.0 82.0 90.0 91.0 83.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#11] stanford-crypto-ccm Cycles:10 Average:116.10 Median:116.00 stddev:4.63 (4.0%) stddev-sans-first:4.67 05:30:21 INFO - PROCESS | 25722 | Values: 112.0 120.0 111.0 125.0 114.0 118.0 113.0 114.0 121.0 113.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.60 Median:136.50 stddev:4.53 (3.3%) stddev-sans-first:3.57 05:30:21 INFO - PROCESS | 25722 | Values: 127.0 131.0 136.0 134.0 136.0 139.0 144.0 137.0 137.0 135.0 05:30:21 INFO - PROCESS | 25722 | 05:30:21 INFO - PROCESS | 25722 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.73 (2.7%) stddev-sans-first:1.79 05:30:21 INFO - PROCESS | 25722 | Values: 64.0 68.0 68.0 64.0 65.0 66.0 63.0 65.0 64.0 64.0 05:30:21 INFO - PROCESS | 25722 | -------- Summary: end -------- 05:30:21 INFO - PROCESS | 25722 | 05:30:22 INFO - TEST-INFO | 25722: exit 0 05:30:22 INFO - TEST-OK | kraken | took 59015ms 05:30:22 INFO - TEST-START | v8_7 05:30:22 INFO - operating with platform_type : linux_ 05:30:22 INFO - Initialising browser for v8_7 test... 05:30:22 INFO - TEST-INFO | started process 26012 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGOe3kA/profile http://localhost:60286/getInfo.html) 05:30:25 INFO - PROCESS | 26012 | 05:30:25 INFO - PROCESS | 26012 | (process:26092): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:30:26 INFO - PROCESS | 26012 | __metrics Screen width/height:1600/1200 05:30:26 INFO - PROCESS | 26012 | colorDepth:24 05:30:26 INFO - PROCESS | 26012 | Browser inner width/height: 1024/697 05:30:26 INFO - PROCESS | 26012 | __metrics 05:30:27 INFO - TEST-INFO | 26012: exit 0 05:30:27 INFO - Browser initialized. 05:30:27 INFO - Running cycle 1/1 for v8_7 test... 05:30:27 INFO - TEST-INFO | started process 26141 (/builds/slave/test-pgo/build/application/firefox/firefox -profile /tmp/tmpGOe3kA/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:28 INFO - PROCESS | 26141 | 05:30:28 INFO - PROCESS | 26141 | (process:26205): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 05:30:39 INFO - PROCESS | 26141 | RSS: Main: 141127680 05:30:39 INFO - PROCESS | 26141 | 05:31:01 INFO - PROCESS | 26141 | Cycle 1(1): loaded http://localhost:60286/tests/v8_7/run.html (next: http://localhost:60286/tests/v8_7/run.html) 05:31:02 INFO - PROCESS | 26141 | RSS: Main: 144969728 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | __start_tp_report 05:31:02 INFO - PROCESS | 26141 | _x_x_mozilla_page_load 05:31:02 INFO - PROCESS | 26141 | _x_x_mozilla_page_load_details 05:31:02 INFO - PROCESS | 26141 | |i|pagename|runs| 05:31:02 INFO - PROCESS | 26141 | |0;Richards;166.333998669328 05:31:02 INFO - PROCESS | 26141 | |1;DeltaBlue;169.63528413910095 05:31:02 INFO - PROCESS | 26141 | |2;Encrypt;278.70680044593087 05:31:02 INFO - PROCESS | 26141 | |3;Decrypt;5191.709844559586 05:31:02 INFO - PROCESS | 26141 | |4;RayTrace;939.8496240601504 05:31:02 INFO - PROCESS | 26141 | |5;Earley;569.8005698005697 05:31:02 INFO - PROCESS | 26141 | |6;Boyer;11292.134831460675 05:31:02 INFO - PROCESS | 26141 | |7;RegExp;40800 05:31:02 INFO - PROCESS | 26141 | |8;Splay;491.2023460410557 05:31:02 INFO - PROCESS | 26141 | |9;NavierStokes;4835.748792270531 05:31:02 INFO - PROCESS | 26141 | __end_tp_report 05:31:02 INFO - PROCESS | 26141 | __startTimestamp1456579862055__endTimestamp 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | ------- Summary: start ------- 05:31:02 INFO - PROCESS | 26141 | Number of tests: 10 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#0] Richards Cycles:1 Average:166.33 Median:166.33 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 166.3 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#1] DeltaBlue Cycles:1 Average:169.64 Median:169.64 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 169.6 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 278.7 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 5191.7 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#4] RayTrace Cycles:1 Average:939.85 Median:939.85 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 939.8 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#5] Earley Cycles:1 Average:569.80 Median:569.80 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 569.8 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#6] Boyer Cycles:1 Average:11292.13 Median:11292.13 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 11292.1 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#7] RegExp Cycles:1 Average:40800.00 Median:40800.00 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 40800.0 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#8] Splay Cycles:1 Average:491.20 Median:491.20 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 491.2 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - PROCESS | 26141 | [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 05:31:02 INFO - PROCESS | 26141 | Values: 4835.7 05:31:02 INFO - PROCESS | 26141 | -------- Summary: end -------- 05:31:02 INFO - PROCESS | 26141 | 05:31:02 INFO - TEST-INFO | 26141: exit 0 05:31:02 INFO - TEST-OK | v8_7 | took 40472ms 05:31:02 INFO - SUITE-END | took 1207s 05:31:03 INFO - Completed test suite (00:20:07) 05:31:03 INFO - Working with test: dromaeo_css 05:31:03 INFO - Generating results file: dromaeo_css 05:31:03 INFO - Working with test: kraken 05:31:03 INFO - Generating results file: kraken 05:31:03 INFO - javascript benchmark 05:31:03 INFO - Working with test: v8_7 05:31:03 INFO - Generating results file: v8_7 05:31:03 INFO - Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:03 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,52,43]] 05:31:03 INFO - process_Request line: dromaeo_css 7275.49 graph.html#tests=[[72,52,43]] 05:31:03 INFO - Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:03 INFO - process_Request line: kraken 1498.30 graph.html#tests=[[232,52,43]] 05:31:03 INFO - Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:31:03 INFO - process_Request line: v8_7 21988.57 graph.html#tests=[[230,52,43]] 05:31:03 INFO - RETURN: dromaeo_css: 7275.49 05:31:03 INFO - RETURN: kraken: 1498.30 05:31:03 INFO - RETURN: v8_7: 21988.57 05:31:03 INFO - javascript benchmark 05:31:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3327.8668853245867, 3338.3990881641294, 3355.4631258998565, 3367.7979321240728, 3383.4417321141996, 5400.945990540094, 5417.0, 5420.783168673253, 5431.076716958117, 5447.428020057896, 5412.051671354261, 5439.755211015504, 5453.318335208099, 5453.863653408666, 5474.91787623186, 4870.196417591102, 4920.237363208708, 5009.0, 5055.646104772667, 5061.493850614946, 4802.951970480303, 4959.752012399384, 4992.475790042048, 5002.824336280989, 5027.170516864713, 4993.500649935014, 5021.17150670139, 5051.898962020758, 5056.0, 5076.44159142494, 5007.649464537484, 5022.0709168803705, 5025.447200807908, 5035.295058691786, 5054.1660625996665, 4808.879778005543, 4893.779779909913, 4905.4358748744, 4941.234108713155, 4976.975115124401, 5212.4266330703595, 5216.530512253916, 5233.869153271161, 5241.42344342122, 5253.395859476171, 5813.128030795372, 5837.737301821428, 5839.036558967765, 5859.648421094706, 5863.442972917566, 5680.403557626431, 5827.067669172954, 5829.737661805187, 5829.795957141522, 5932.317783454915, 5524.696141712204, 5559.388467268597, 5559.8888022239735, 5576.749046292967, 5601.439856014406, 5916.556258280646, 5930.436608522184, 5941.494972927263, 5942.227510423617, 5946.07835785454, 5545.473180047969, 5589.273394458775, 5651.576131790132, 5713.085906254979, 5716.599838011382, 5848.0, 5849.298084229835, 5850.502707269845, 5852.970735146297, 5857.736401861926, 5815.214945982323, 5815.360310365856, 5820.592558520862, 5825.679587622722, 5841.912371314434, 5670.5180059695385, 5768.913466298009, 5772.278465191851, 5799.797007104731, 5862.325832529228, 4474.821007159742, 4475.507694153641, 4513.11994161142, 4522.3668686383935, 4528.750918699503, 4045.554988951213, 4055.5944405559208, 4060.26915155269, 4079.938800917989, 4089.5501494835544, 5392.0, 5474.042042642522, 5596.720163991784, 5609.0, 5668.319801623831, 5803.274590676166, 5810.970945145332, 5847.590668653239, 5861.208736820475, 5861.853453663693, 5381.165919282517, 5517.751701173457, 5528.889422211533, 5535.501804837503, 5541.556675465953, 5034.521720436553, 5073.695578265316, 5092.134337162691, 5124.180131178993, 5131.332926719577, 5925.0, 5967.910481342783, 5993.280806303272, 6019.789307374309, 6033.18551995475, 5747.080467125407, 5829.0, 5830.0, 5832.9708351457975, 5835.649861008353, 5979.461848433488, 6012.308584512837, 6013.819585412444, 6070.3929607038945, 6103.176071230327, 5674.035413979551, 5724.141378793214, 5806.970965145148, 5834.15404766298, 5839.795607153729, 5719.542436605145, 5845.590808643524, 5846.41535846412, 5855.8536036597725, 5903.203067585992, 5774.220480235283, 5786.450287222707, 5792.3917988612275, 5800.535957123504, 5812.418758124323, 5745.540356771365, 5746.281714785652, 5761.5390768739235, 5765.654060756368, 5767.913481297868, 5528.308961379827, 5584.301962254718, 5609.49514543693, 5672.2058911751565, 5698.1737648041635, 5654.943450565442, 5698.458646428583, 5715.971420143039, 5722.885542289047, 5747.3103227612955, 5579.442055794388, 5600.719964001865, 5631.070873306023, 5639.464250896158, 5658.094704847369], "unit": "score", "name": "dojo.html", "value": 5391.887357391079}, {"lowerIsBetter": false, "replicates": [506.3088883673784, 515.2734644151747, 517.6195496310212, 519.3819354967586, 538.7117891927818, 29845.403091938177, 36880.44679329812, 37011.4448283276, 37061.81469092654, 37169.07077323065, 40977.795111024476, 41832.581674183246, 41849.37225941613, 41914.0, 42075.158496830045, 8690.435121717084, 8903.24322432594, 8932.910670893305, 8953.820923581558, 8980.775480613005, 8588.8711669325, 8723.084076172006, 8747.562621868912, 8752.781180470476, 8963.103689631018, 8949.149830766068, 8988.505632190227, 9004.919409670849, 9005.009448960609, 9040.547972601344, 8884.067172946876, 8907.109289071106, 8971.416857904216, 8971.865422018675, 8977.910220897773, 8868.955655221747, 8891.911080889238, 8909.109089091038, 8913.286937045086, 8992.505412202327, 41669.1666166678, 41873.581264187276, 41975.580244197474, 41984.1603167938, 42001.57998420007, 3422.2299982503987, 3511.9122021949656, 3599.892003239907, 3781.6974642028845, 3951.7826519541413, 30694.232644183852, 30894.22764430885, 31275.218119546968, 31490.685093149234, 31893.0, 4281.620385625427, 4335.978320108411, 4370.912581748379, 4406.515283318832, 4437.334399840018, 280066.5996670024, 280209.0, 280655.0, 281268.0, 281379.0, 58130.709346453, 58898.41101589015, 62661.68669156716, 63815.36184638187, 63862.680686597196, 56636.716816415654, 56915.430845691844, 56928.43071569231, 57026.714866425405, 57147.0, 16952.067636280124, 17011.40460083916, 17042.31830726782, 17072.743908841378, 17084.145792710315, 14195.64510887236, 14240.359183836752, 14265.857341426452, 14300.213488258038, 14392.784108238386, 20651.8967405162, 20886.791132088787, 20942.267020654508, 21057.26299579538, 21073.473163171042, 8085.312748416451, 8322.916770832335, 8333.874991875127, 8346.540940248224, 8373.581320933929, 973.6835528453281, 1046.6755305855208, 1071.4589132488043, 1121.5233525751687, 1148.0012389221265, 29468.852655736584, 29855.850720746257, 29926.55110173349, 30262.09213723592, 30298.24254393658, 1100.9779804404027, 1139.1285666464996, 1144.3420033480782, 1149.3391300002531, 1218.750156217991, 14115.71768564623, 14197.219152946687, 14264.072835265675, 14294.785578216335, 14400.567982960529, 321358.0, 487531.0, 488070.0, 489991.0, 693590.0, 54826.0, 55713.0, 55746.72126639341, 56103.0, 56175.0, 1443.314425647809, 1448.7537118689847, 1461.5469204546625, 1462.3565631122271, 1477.9801936663669, 31033.68966310308, 32158.839205803823, 32279.838600806845, 32687.34625307528, 32759.0172294822, 52802.207966881295, 53530.464695352544, 53533.99999999844, 53848.19227711509, 53892.46107539031, 308344.0, 311796.0, 311858.0, 311958.0, 312202.0, 45002.0, 45162.32256516089, 45450.772746136056, 45667.0, 45918.770406147756, 47116.7644161777, 47764.2835357463, 47886.0, 48407.757961209965, 48497.0, 40861.591384085776, 41455.7927210362, 42370.26836898081, 42524.0, 42909.785451072545, 41059.0, 41103.58896411117, 41475.0, 41569.58430415657, 42035.0, 41070.58929410668, 41085.58914410818, 41155.1768964625, 41291.0, 41880.162396751286, 30975.380492390475, 31808.36383272368, 31836.5224521637, 31948.68051319457, 32098.83950580232, 27776.722232778222, 27811.304717382227, 27824.0, 27946.0, 28662.14013579596], "unit": "score", "name": "ext.html", "value": 19919.487545959775}, {"lowerIsBetter": false, "replicates": [385.4622801192337, 386.3605732512693, 387.81191122305677, 389.3808843938138, 395.5154935204373, 14030.368633411495, 15900.92049539752, 16587.66824663506, 18282.54293642658, 18408.171632276546, 15982.520524384257, 15999.92000040001, 16391.508254752345, 16822.57943551412, 16826.579335516617, 5284.365876094865, 5395.541378982772, 5409.756560954766, 5453.863653408676, 5458.808941687042, 5265.131253343194, 5337.67973921564, 5460.153676180179, 5483.533899618537, 5504.697241651707, 5196.532312091911, 5403.972980135094, 5416.620836541424, 5459.153831156157, 5487.533559647435, 5391.460853914597, 5417.4853388927795, 5446.591505637073, 5820.621659592113, 6098.969505152446, 5441.619086663935, 5447.918281225785, 5459.972700136474, 5485.286912701363, 5488.094464413367, 16830.663386732198, 20469.8976505118, 20678.483037924023, 20832.79167208339, 21319.040643171094, 2174.1738139507042, 2174.662927246279, 2191.802737753594, 2246.7753224677563, 2403.3510952042852, 9296.860547091732, 9336.673216437392, 9415.058494150599, 9469.90530094704, 10859.565617375296, 1885.8868467891832, 1903.8857668539792, 1913.1868955693913, 1916.32928475034, 1944.562473443478, 55050.9999999996, 60091.39908600946, 60337.39662603362, 61819.0, 62323.0, 10223.591056357662, 10490.685279441628, 10494.790104197873, 10574.154067674568, 10667.679969600924, 13706.246156461291, 13726.313684315945, 13756.243406612532, 13827.377768000464, 13847.376868040963, 7802.180771019075, 7885.645145968445, 7901.367890568741, 8185.631646575918, 8234.217749313806, 7759.379249660014, 7776.339011184, 7841.529508229411, 7889.0, 8269.917300827035, 4501.324801279834, 4695.694779839299, 4737.549932756383, 4752.310914917318, 4811.4707382187935, 1893.6023435078787, 1965.3710812540137, 1966.5771859050374, 1987.224982256921, 1993.9302124425576, 974.3423189347162, 987.6345752071779, 1027.091024443373, 1117.932924024561, 1127.6278827986744, 14775.187364695044, 15304.311305991258, 16509.66980660404, 16932.0, 17934.820651793314, 1025.7435641089728, 1028.4908970059869, 1051.1208986984648, 1067.514281002142, 1081.1566977757361, 9967.651132210338, 10019.849702254473, 10040.548175332127, 10061.647842325483, 10072.74818129538, 532763.0, 541277.0, 553828.0, 555398.0, 555698.0, 75275.0, 75772.0, 77317.61341193259, 77459.0, 77637.22362776414, 1157.988420115805, 1165.2658824940233, 1166.9241499302518, 1187.1867770577182, 1187.5249900040053, 15557.144357060017, 15566.599006089506, 15717.607059823138, 15733.685326293182, 15908.284127214534, 34611.0, 35077.824610876785, 35132.0, 35434.645653543135, 35470.290594187456, 44577.0, 45022.324665129396, 45324.546754532035, 45853.31220031635, 46209.0, 7229.385502232369, 7291.598962057138, 7380.520266182681, 7499.88750168737, 7595.924040759522, 11071.391073491035, 11381.374024428405, 11622.70943226426, 11914.10644201671, 12077.154599177973, 10075.34510256831, 10260.435676037889, 10609.0, 10657.360558366523, 10702.304350217211, 10144.74638134023, 10392.0, 10444.791104178026, 10731.946340268249, 10989.120870330195, 3369.9326013480086, 6113.052476866093, 7073.6816843243205, 10420.977916404157, 10757.569697212024, 7728.922710773045, 7739.380849532136, 7742.264484873928, 7750.844983100419, 8038.0, 10998.36366538931, 11108.0, 11127.276727012719, 11166.553337866395, 11338.319700817978], "unit": "score", "name": "jquery.html", "value": 8509.293614904023}, {"lowerIsBetter": false, "replicates": [1502.541724773944, 1532.210911380639, 1704.2075434922758, 1818.6362727454496, 1855.5732181598232, 7638.656260468279, 7859.331956783681, 7872.448928575002, 7925.405594580415, 8179.059408168063, 8326.66693332266, 8327.500349979005, 8385.287250583708, 8423.284020858235, 8450.661973521068, 2409.6506006629074, 2420.636904464327, 2423.7939775119135, 2438.036975394718, 2447.400386905211, 2443.743406942272, 2464.100603279799, 2467.3954881054165, 2472.5425796227664, 2478.293686299405, 2391.198948352304, 2446.559619268531, 2446.6207737800582, 2449.963250551243, 2460.052879641342, 2374.8693821839793, 2399.556082124795, 2410.0600765701392, 2413.879306034691, 2421.0678888628004, 2352.5765362234793, 2366.171839856054, 2366.2664573981947, 2367.7277113132036, 2368.4789346343778, 7837.216278372174, 7899.526028438255, 7922.405819563556, 7990.840183196362, 7998.960005199995, 4990.326305948687, 5079.0, 5093.134167191549, 5118.923216151761, 5124.615653825978, 3260.934781304384, 3313.933721325584, 3343.5319055332275, 3349.8492567834505, 3368.360011597789, 1073.280901795791, 1075.3547871277249, 1098.4343063322394, 1116.7598966222301, 1127.7575321305958, 11186.888131118665, 11282.266652667633, 11312.208145429824, 11317.603883864025, 11360.204785665006, 4464.464264288306, 4531.184386810406, 4536.750478723636, 4573.611243044378, 4578.084383123389, 9661.372010819274, 9681.854772178423, 9705.12653861156, 9715.46564938935, 9744.951275243578, 5071.87320316995, 5091.032703786269, 5091.1854103343285, 5112.9744351278005, 5114.514121158484, 4582.289745089516, 4593.0, 4594.471635761864, 4597.3333866589155, 4612.400387949612, 3820.84716611338, 3831.8658846940225, 3863.478430411915, 3867.613238676166, 3896.162325100117, 1202.296656455983, 1212.0, 1215.5623975369037, 1220.5850010996303, 1236.863944966053, 1083.2146693647044, 1133.5125895864858, 1217.1966502108567, 1302.7785276503016, 1365.863413658646, 7252.927470725225, 7268.781936541912, 7390.704371825174, 7409.592472413961, 7430.034095567542, 616.7532986805224, 625.293418437163, 627.1063734178776, 635.2377147423018, 785.952842829432, 5756.33802112754, 5760.279965004374, 5796.884062318814, 5811.622244554091, 5877.206577112035, 9351.438913665066, 9755.951220243853, 9785.168260697921, 9934.105930466148, 10093.192544596415, 9612.855807162898, 9782.0, 9911.405315680939, 9966.501674916226, 9975.401475911323, 7432.814179645552, 7560.659770310349, 7585.393168546503, 7594.886076708854, 7621.199774023758, 7192.892106618509, 7384.593847338448, 7391.926080739124, 7409.8147546311775, 7429.591372474566, 8601.65593376283, 8709.651613935372, 8898.243649289883, 9056.460401731852, 9091.136342047495, 9028.18746312835, 9081.591328390106, 9093.454392736458, 9120.087991201091, 9139.405938613969, 7186.281371862772, 7274.4907856451655, 7285.0, 7320.341169294789, 7321.414286857145, 7769.72805951789, 7775.261350171724, 7848.450608457581, 7856.175101614248, 7874.56689882062, 7196.388306993755, 7403.629818508945, 7416.44376671741, 7457.291557302047, 7740.26467485588, 7008.7546935857, 7077.0, 7128.607926564089, 7184.317489838457, 7282.890756638549, 7357.0, 7419.07261592301, 7431.554106753612, 7456.96271518639, 7466.402687785073, 6631.933680663132, 6660.966695166493, 6662.400383965466, 6701.698423570853, 6734.4275736560985, 6686.231083425274, 6712.664366781739, 6761.154855643044, 6886.414654754402, 6887.242403335729], "unit": "score", "name": "mootools.html", "value": 4656.73127592964}, {"lowerIsBetter": false, "replicates": [352.3956414748706, 361.9674229319361, 362.5160410851513, 365.7330148991238, 365.90669379308275, 6284.685765711708, 6332.905006424908, 6424.132742079818, 6432.839179020515, 6448.226212854464, 6195.721192546335, 6345.333739957296, 6376.202974628171, 6395.968020159904, 6398.040293955897, 4842.830500932468, 4877.926831097528, 4889.608831293505, 4892.926606100911, 4894.632902532307, 4883.243097319921, 4902.5342592453835, 4904.435989861176, 4909.7545122743895, 4915.262710593403, 4687.624990000809, 4823.469418363995, 4826.734529600871, 4841.951580484185, 4843.321934929095, 4815.807367705288, 4824.493428190042, 4828.589569886564, 4829.058333624945, 4837.395325584302, 4208.305629571148, 4208.957910420918, 4215.325547912319, 4221.746695198267, 4235.0, 5889.8822023559715, 6014.12795144706, 6047.092936059582, 6063.939360606426, 6069.817905462844, 5618.8033418830555, 5640.069388550925, 5653.802116925888, 5655.915161272543, 5666.376698563155, 6680.565763225423, 6681.53229273951, 6705.731770729165, 6709.731610735565, 6732.091167692348, 4610.9077818443775, 4680.134175177603, 4691.390119284505, 4710.670253082286, 4712.387389639359, 6925.99999999995, 7005.719771209146, 7095.964520177417, 7098.645067746592, 7099.0, 4768.117898188846, 4793.304970779218, 4805.927911081267, 4821.2045012572535, 4830.589399900978, 4840.854774356775, 4859.684120532154, 4889.535494128123, 4897.1674815281485, 4899.8285060023445, 5471.015217260851, 5602.943970560324, 5641.787015791624, 5654.575906807006, 5660.830175094754, 6766.052752614638, 6794.524383293122, 6800.251972283045, 6816.182058152955, 6830.556013859084, 1676.9161541922856, 1716.828317168298, 1721.3544920654754, 1728.1877517566975, 1731.809500954894, 1136.4545018391218, 1163.8312444695641, 1168.8480497535265, 1177.5937301630925, 1183.3728124094243, 6409.903851442232, 6412.903806442907, 6424.903626445607, 6431.0, 6464.353564643498, 6894.24163342032, 6903.930960690429, 6907.930920690829, 6909.239983601799, 6910.30896910315, 6412.422881940648, 6417.005364168468, 6418.293987661354, 6431.742730290736, 6443.194600674916, 3771.86798462058, 3784.905377365588, 3786.886393408147, 3793.5827059023486, 3795.259924314732, 7201.3158749918675, 7216.206217316091, 7242.746503872339, 7294.0, 7307.671154798047, 7100.254473280334, 7166.641667916583, 7170.641467926583, 7236.204017558064, 7250.963745181346, 7276.927230727731, 7281.1262648482525, 7298.598577078312, 7303.415726741848, 7304.488685791944, 7025.578465291895, 7026.718931242693, 7035.718571257093, 7069.858602828018, 7081.4334853210585, 6771.695273712793, 6893.138357705287, 6934.757283495255, 6955.617441040791, 7000.404965577983, 7270.163931147986, 7278.927210727825, 7311.41508679315, 7313.268673132857, 7336.229695881855, 4842.225243960949, 4846.975765121152, 4851.660383773243, 4862.367892173995, 4869.050535145612, 6875.7937261882225, 6907.827304317432, 7016.543924644881, 7074.646267686698, 7086.964565177141, 6760.93239067603, 6837.829054273683, 6858.348456896587, 6885.758998435031, 6900.447964162955, 6836.418904393182, 6852.554583952027, 6861.759838405632, 6869.622170780655, 6873.725050997904, 6625.50926041656, 6713.563618364986, 6759.662016899037, 6779.762678316045, 6801.217859945971, 6859.348361905611, 6893.379595836399, 6911.101556797584, 6913.582715543201, 6929.1684997800585, 6657.201135863727, 6677.098591690254, 6680.265170831108, 6686.69909854048, 6687.732490700512], "unit": "score", "name": "prototype.html", "value": 5116.384876523574}, {"lowerIsBetter": false, "replicates": [730.408369220931, 743.1565173528047, 785.9607019649017, 798.2576204130161, 905.551751882818, 13267.601971940845, 13361.198328100321, 13527.864721352784, 13550.932245338785, 13559.11865728727, 13347.866521334783, 13408.26254555999, 13551.25468099254, 13568.118072325293, 15351.769723454157, 854.7179430787857, 864.6282098697558, 869.2784988459564, 869.5391442535466, 870.4733636150102, 877.403365711316, 879.0155026370473, 882.4572887674067, 887.2990337633262, 887.4409122252972, 904.5658084119626, 910.6175406329324, 914.1315750037458, 917.0691747875911, 918.3846822628822, 908.3505293714959, 909.4497828813605, 910.8087301666658, 913.0914739833842, 915.6612053540166, 661.0678942690831, 672.3041651890319, 673.3603077076797, 675.0717763075771, 676.1345477788439, 14291.714165716732, 14370.425182992667, 14374.20941848198, 14383.856161438356, 14425.0, 12881.67795805103, 12882.291473968928, 13023.088383813138, 13204.735905281937, 13211.537596184184, 11160.441977901073, 11623.0, 11633.185677002613, 11746.236494627821, 11831.349275789828, 3862.208247309295, 3892.299386110499, 3902.9804850975847, 3924.4701965234613, 3936.8425262989444, 49420.75289623529, 49463.0, 49984.50015499835, 50239.74880125612, 51888.74055629735, 10789.0, 10895.891041089488, 11166.441677916235, 11187.440627968732, 11269.267497612629, 18175.272989080553, 18335.44993650166, 18380.264789408542, 18409.723854142198, 18458.723119153223, 8182.918170818335, 8345.165483451729, 8413.74758757226, 8414.326853851677, 8430.662773488992, 4418.182636212311, 4559.270516717309, 4570.415768432252, 4600.01487394337, 4604.621455555519, 3104.8758049678213, 3117.8908738194054, 3128.5307203919137, 3144.261098641817, 3149.4488464519077, 583.0816464069109, 640.4396153365805, 641.8748344072861, 645.5061877663591, 654.0516251435438, 731.1737736357987, 733.4999925153074, 775.7789030126387, 778.4628606261662, 787.9960600196962, 8681.826363472695, 9792.608295668093, 9792.706218813448, 9861.408315501092, 9939.950300248596, 648.24803228255, 661.599732162035, 760.6957217113088, 776.6543887969799, 778.2140038560981, 4217.430646862635, 4258.510271318776, 4288.785560721952, 4331.350297455407, 4479.372887795711, 57884.71057644685, 58105.70947145237, 58370.0, 58481.70759146177, 58945.705271474224, 46803.0, 53619.92760144775, 54018.0, 54411.45588544143, 54604.45395546073, 48479.0, 49112.75443622759, 49473.50526494761, 50008.49991500111, 50056.24915626268, 9342.626294948397, 9475.952620236854, 9507.096825801538, 9596.520173991412, 9691.07934746198, 36370.8181459091, 36938.44592331063, 37149.071273217305, 37474.8126259367, 37577.248455031295, 44076.55923440853, 45252.0, 48465.27302090401, 48579.5142048575, 48913.51086489089, 11793.52825886955, 12123.272603643809, 12147.757044858876, 12193.268403895794, 12309.384530773246, 13144.802827957397, 13496.595102146952, 13927.791083133963, 13987.510437134652, 14520.491782787552, 12521.749565008831, 12579.811302830281, 12769.87230127724, 12943.482260709467, 13661.726765464833, 12516.749665006831, 12544.372781360713, 13117.08180427399, 13333.799993000306, 13465.932670336586, 12760.6809829755, 12865.485380584672, 12872.613821585368, 13276.86723132795, 13427.12723672958, 9898.653547125816, 10279.845802312822, 10313.845292320471, 10329.225308101772, 10403.063724264852, 10595.629152979609, 10900.7274818127, 11073.16951228645, 11121.721956950818, 11265.380404077854], "unit": "score", "name": "yui.html", "value": 6810.508055787208}], "name": "dromaeo_css", "value": 7275.490056141229}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 105.0, 111.0, 111.0, 112.0, 121.0, 110.0, 114.0, 115.0, 111.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [149.0, 133.0, 159.0, 167.0, 125.0, 157.0, 153.0, 128.0, 167.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 146.4}, {"lowerIsBetter": true, "replicates": [164.0, 163.0, 161.0, 164.0, 161.0, 165.0, 161.0, 161.0, 163.0, 162.0], "unit": "score", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [72.0, 75.0, 76.0, 159.0, 74.0, 72.0, 73.0, 73.0, 163.0, 75.0], "unit": "score", "name": "audio-fft", "value": 91.2}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 142.0, 98.0, 96.0, 96.0, 139.0, 96.0, 95.0, 134.0], "unit": "score", "name": "audio-oscillator", "value": 108.7}, {"lowerIsBetter": true, "replicates": [111.0, 110.0, 110.0, 109.0, 109.0, 111.0, 110.0, 110.0, 109.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [97.0, 96.0, 96.0, 97.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0], "unit": "score", "name": "imaging-desaturate", "value": 96.5}, {"lowerIsBetter": true, "replicates": [55.0, 56.0, 55.0, 56.0, 56.0, 58.0, 55.0, 61.0, 57.0, 63.0], "unit": "score", "name": "json-parse-financial", "value": 57.2}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.5}, {"lowerIsBetter": true, "replicates": [88.0, 81.0, 84.0, 82.0, 83.0, 89.0, 82.0, 90.0, 91.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.3}, {"lowerIsBetter": true, "replicates": [112.0, 120.0, 111.0, 125.0, 114.0, 118.0, 113.0, 114.0, 121.0, 113.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 116.1}, {"lowerIsBetter": true, "replicates": [127.0, 131.0, 136.0, 134.0, 136.0, 139.0, 144.0, 137.0, 137.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.6}, {"lowerIsBetter": true, "replicates": [64.0, 68.0, 68.0, 64.0, 65.0, 66.0, 63.0, 65.0, 64.0, 64.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1498.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.333998669328], "unit": "score", "name": "Richards", "value": 212.23562399999997}, {"lowerIsBetter": false, "replicates": [169.63528413910095], "unit": "score", "name": "DeltaBlue", "value": 389.76561000000004}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [939.8496240601504], "unit": "score", "name": "RayTrace", "value": 787.3482960000001}, {"lowerIsBetter": false, "replicates": [569.8005698005697], "unit": "score", "name": "Earley", "value": 1169.642565}, {"lowerIsBetter": false, "replicates": [11292.134831460675], "unit": "score", "name": "Boyer", "value": 59.02010646766172}, {"lowerIsBetter": false, "replicates": [40800.0], "unit": "score", "name": "RegExp", "value": 22.328063725490182}, {"lowerIsBetter": false, "replicates": [491.2023460410557], "unit": "score", "name": "Splay", "value": 165.90108059701487}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 21988.569651503774}]} 05:31:03 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,52,43]]", "result": "21988.57"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,52,43]]", "result": "1498.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,52,43]]", "result": "7275.49"}}} 05:31:03 INFO - Return code: 0 05:31:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test-pgo/build/tests/talos/treeherder-schemas/performance-artifact.json 05:31:03 INFO - # TBPL SUCCESS # 05:31:03 INFO - Running post-action listener: _resource_record_post_action 05:31:03 INFO - Running post-run listener: _resource_record_post_run 05:31:04 INFO - Total resource usage - Wall time: 1224s; CPU: 13.0%; Read bytes: 0; Write bytes: 507736064; Read time: 0; Write time: 532700 05:31:04 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 248995840; Read time: 0; Write time: 348152 05:31:04 INFO - run-tests - Wall time: 1210s; CPU: 13.0%; Read bytes: 0; Write bytes: 258740224; Read time: 0; Write time: 184548 05:31:04 INFO - Running post-run listener: _upload_blobber_files 05:31:04 INFO - Blob upload gear active. 05:31:04 INFO - Preparing to upload files from /builds/slave/test-pgo/build/blobber_upload_dir. 05:31:04 INFO - Files from /builds/slave/test-pgo/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:31:04 INFO - Running command: ['/builds/slave/test-pgo/build/venv/bin/python', '/builds/slave/test-pgo/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test-pgo/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test-pgo/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test-pgo/build/uploaded_files.json'] 05:31:04 INFO - Copy/paste: /builds/slave/test-pgo/build/venv/bin/python /builds/slave/test-pgo/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test-pgo/oauth.txt -b Mozilla-Aurora -d /builds/slave/test-pgo/build/blobber_upload_dir --output-manifest /builds/slave/test-pgo/build/uploaded_files.json 05:31:04 INFO - (blobuploader) - INFO - Open directory for files ... 05:31:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:31:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:31:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:05 INFO - (blobuploader) - INFO - Done attempting. 05:31:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test-pgo/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:31:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:31:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:31:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:31:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:31:06 INFO - (blobuploader) - INFO - Done attempting. 05:31:06 INFO - (blobuploader) - INFO - Iteration through files over. 05:31:06 INFO - Return code: 0 05:31:06 INFO - rmtree: /builds/slave/test-pgo/build/uploaded_files.json 05:31:06 INFO - retry: Calling remove with args: ('/builds/slave/test-pgo/build/uploaded_files.json',), kwargs: {}, attempt #1 05:31:06 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5367567d78068125db4d1829713f8967c4d9eb786cd74a87c940f9eeed2ebf433215a70363bd98d9a021f56bb7da36be7880044ab0da1ebeb587b8cbbdd30ba0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/198fb14d98e509171454b1bef11edc4855fad68f01a20eb9c81c1ccf4dd4cb8ac353d92b7591e034e40913a346c33920fa7b0866773bf823b45477d029865639"} 05:31:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test-pgo/properties/blobber_files 05:31:06 INFO - Writing to file /builds/slave/test-pgo/properties/blobber_files 05:31:06 INFO - Contents: 05:31:06 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/5367567d78068125db4d1829713f8967c4d9eb786cd74a87c940f9eeed2ebf433215a70363bd98d9a021f56bb7da36be7880044ab0da1ebeb587b8cbbdd30ba0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/198fb14d98e509171454b1bef11edc4855fad68f01a20eb9c81c1ccf4dd4cb8ac353d92b7591e034e40913a346c33920fa7b0866773bf823b45477d029865639"} 05:31:06 INFO - Running post-run listener: copy_logs_to_upload_dir 05:31:06 INFO - Copying logs to upload dir... 05:31:06 INFO - mkdir: /builds/slave/test-pgo/build/upload/logs 05:31:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.518682 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-02-27 05:31:05.266538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:05.269623) ========= 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=6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181 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/5367567d78068125db4d1829713f8967c4d9eb786cd74a87c940f9eeed2ebf433215a70363bd98d9a021f56bb7da36be7880044ab0da1ebeb587b8cbbdd30ba0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/198fb14d98e509171454b1bef11edc4855fad68f01a20eb9c81c1ccf4dd4cb8ac353d92b7591e034e40913a346c33920fa7b0866773bf823b45477d029865639"} 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.011427 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/5367567d78068125db4d1829713f8967c4d9eb786cd74a87c940f9eeed2ebf433215a70363bd98d9a021f56bb7da36be7880044ab0da1ebeb587b8cbbdd30ba0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/198fb14d98e509171454b1bef11edc4855fad68f01a20eb9c81c1ccf4dd4cb8ac353d92b7591e034e40913a346c33920fa7b0866773bf823b45477d029865639"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:05.294510) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:05.294835) ========= 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=6dbc10da6d83fee962c624be000001a8-1456578600.794402-932162181 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004692 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-27 05:31:05.378291) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:31:05.378607) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-27 05:31:05.378918) ========= ========= Total master_lag: 0.25 =========