builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0022 starttime: 1465219687.44 results: success (0) buildid: 20160603143526 builduid: a64d0f16f5ec47b082edbf193c05af18 revision: a86835580095325bf5c85483fad952f5c99d973e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:07.435356) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:07.435824) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:07.436126) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:07.458258) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:07.458643) ========= 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/. (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: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kOffrYcyn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners TMPDIR=/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-06-06 06:28:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to 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% 14.1M=0.001s 2016-06-06 06:28:07 (14.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082709 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:07.561525) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:07.561841) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kOffrYcyn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners TMPDIR=/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.019977 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:07.610524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:07.610886) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a86835580095325bf5c85483fad952f5c99d973e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a86835580095325bf5c85483fad952f5c99d973e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kOffrYcyn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners TMPDIR=/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-06-06 06:28:07,685 truncating revision to first 12 chars 2016-06-06 06:28:07,685 Setting DEBUG logging. 2016-06-06 06:28:07,686 attempt 1/10 2016-06-06 06:28:07,686 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a86835580095?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 06:28:07,987 unpacking tar archive at: mozilla-beta-a86835580095/testing/mozharness/ program finished with exit code 0 elapsedTime=0.559767 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:08.191418) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:08.191722) ========= script_repo_revision: a86835580095325bf5c85483fad952f5c99d973e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:08.192110) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:08.192374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 06:28:08.210508) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-06 06:28:08.210780) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kOffrYcyn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners TMPDIR=/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 06:28:08 INFO - MultiFileLogger online at 20160606 06:28:08 in /builds/slave/test 06:28:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 06:28:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:28:08 INFO - {'append_to_log': False, 06:28:08 INFO - 'base_work_dir': '/builds/slave/test', 06:28:08 INFO - 'blob_upload_branch': 'Mozilla-Beta', 06:28:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:28:08 INFO - 'branch': 'Mozilla-Beta', 06:28:08 INFO - 'buildbot_json_path': 'buildprops.json', 06:28:08 INFO - 'config_files': ('talos/mac_config.py',), 06:28:08 INFO - 'default_actions': ('clobber', 06:28:08 INFO - 'read-buildbot-config', 06:28:08 INFO - 'download-and-extract', 06:28:08 INFO - 'populate-webroot', 06:28:08 INFO - 'create-virtualenv', 06:28:08 INFO - 'install', 06:28:08 INFO - 'run-tests'), 06:28:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:28:08 INFO - 'download_minidump_stackwalk': True, 06:28:08 INFO - 'download_symbols': 'ondemand', 06:28:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:28:08 INFO - 'tooltool.py': '/tools/tooltool.py', 06:28:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:28:08 INFO - '/tools/misc-python/virtualenv.py')}, 06:28:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:28:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:28:08 INFO - 'installer_path': 'installer.exe', 06:28:08 INFO - 'log_level': 'info', 06:28:08 INFO - 'log_name': 'talos', 06:28:08 INFO - 'log_to_console': True, 06:28:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:28:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:28:08 INFO - 'opt_config_files': (), 06:28:08 INFO - 'pip_index': False, 06:28:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:28:08 INFO - 'cmd': ('bash', 06:28:08 INFO - '-c', 06:28:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:28:08 INFO - 'enabled': True, 06:28:08 INFO - 'halt_on_failure': False, 06:28:08 INFO - 'name': 'check_screen_resolution'},), 06:28:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:28:08 INFO - 'cmd': ('bash', 06:28:08 INFO - '-c', 06:28:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:28:08 INFO - 'enabled': True, 06:28:08 INFO - 'halt_on_failure': False, 06:28:08 INFO - 'name': 'check_screen_resolution'},), 06:28:08 INFO - 'run_cmd_checks_enabled': True, 06:28:08 INFO - 'sps_profile': False, 06:28:08 INFO - 'sps_profile_interval': 0, 06:28:08 INFO - 'suite': 'dromaeojs', 06:28:08 INFO - 'system_bits': '32', 06:28:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:28:08 INFO - 'title': 't-yosemite-r7-0022', 06:28:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:28:08 INFO - 'use_talos_json': True, 06:28:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:28:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:28:08 INFO - 'work_dir': 'build'} 06:28:08 INFO - ##### 06:28:08 INFO - ##### Running clobber step. 06:28:08 INFO - ##### 06:28:08 INFO - Running pre-action listener: _resource_record_pre_action 06:28:08 INFO - Running main action method: clobber 06:28:08 INFO - rmtree: /builds/slave/test/build 06:28:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:28:09 INFO - Running post-action listener: _resource_record_post_action 06:28:09 INFO - ##### 06:28:09 INFO - ##### Running read-buildbot-config step. 06:28:09 INFO - ##### 06:28:09 INFO - Running pre-action listener: _resource_record_pre_action 06:28:09 INFO - Running main action method: read_buildbot_config 06:28:09 INFO - Using buildbot properties: 06:28:09 INFO - { 06:28:09 INFO - "project": "", 06:28:09 INFO - "product": "firefox", 06:28:09 INFO - "script_repo_revision": "production", 06:28:09 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 06:28:09 INFO - "repository": "", 06:28:09 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 06:28:09 INFO - "buildid": "20160603143526", 06:28:09 INFO - "pgo_build": "False", 06:28:09 INFO - "basedir": "/builds/slave/test", 06:28:09 INFO - "buildnumber": 21, 06:28:09 INFO - "slavename": "t-yosemite-r7-0022", 06:28:09 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 06:28:09 INFO - "platform": "yosemite_r7", 06:28:09 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 06:28:09 INFO - "branch": "mozilla-beta", 06:28:09 INFO - "repo_path": "releases/mozilla-beta", 06:28:09 INFO - "revision": "a86835580095325bf5c85483fad952f5c99d973e", 06:28:09 INFO - "stage_platform": "macosx64", 06:28:09 INFO - "builduid": "a64d0f16f5ec47b082edbf193c05af18", 06:28:09 INFO - "slavebuilddir": "test" 06:28:09 INFO - } 06:28:09 INFO - Found installer url https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 06:28:09 INFO - Running post-action listener: _resource_record_post_action 06:28:09 INFO - ##### 06:28:09 INFO - ##### Running download-and-extract step. 06:28:09 INFO - ##### 06:28:09 INFO - Running pre-action listener: _resource_record_pre_action 06:28:09 INFO - Running main action method: download_and_extract 06:28:09 INFO - mkdir: /builds/slave/test/build/tests 06:28: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')]} 06:28:09 INFO - https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 06:28:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:28:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 06:28:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:28:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 06:28:10 INFO - Downloaded 1241 bytes. 06:28:10 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 06:28:10 INFO - Using the following test package requirements: 06:28:10 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:28:10 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:28:10 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 06:28:10 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:28:10 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 06:28:10 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 06:28:10 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:28:10 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 06:28:10 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:28:10 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:28:10 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 06:28:10 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:28:10 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 06:28:10 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:28:10 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 06:28:10 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 06:28:10 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 06:28:10 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 06:28:10 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 06:28: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')]} 06:28:10 INFO - https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:28:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:28:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:28:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:28:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:28:11 INFO - Downloaded 17816932 bytes. 06:28:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:28:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:28:15 INFO - Return code: 0 06:28:15 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 06:28:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:15 INFO - https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 06:28:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:28:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 06:28:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 06:28:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 06:28:16 INFO - Downloaded 17816932 bytes. 06:28:16 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:28:16 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 06:28:19 INFO - Return code: 0 06:28:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:19 INFO - https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 06:28:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:28:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 06:28:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 06:28:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 06:28:21 INFO - Downloaded 10845194 bytes. 06:28:21 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 06:28:21 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 06:28:21 INFO - Return code: 0 06:28:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:21 INFO - https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 06:28:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:28:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:28:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 06:28:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 06:28:23 INFO - Downloaded 88466058 bytes. 06:28:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:28:23 INFO - mkdir: /builds/slave/test/properties 06:28:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:28:23 INFO - Writing to file /builds/slave/test/properties/build_url 06:28:23 INFO - Contents: 06:28:23 INFO - build_url:https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg 06:28:25 INFO - Running post-action listener: _resource_record_post_action 06:28:25 INFO - Running post-action listener: set_extra_try_arguments 06:28:25 INFO - ##### 06:28:25 INFO - ##### Running populate-webroot step. 06:28:25 INFO - ##### 06:28:25 INFO - Running pre-action listener: _resource_record_pre_action 06:28:25 INFO - Running main action method: populate_webroot 06:28:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:28:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:28:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:28:25 INFO - '--tppagecycles', 06:28:25 INFO - '7'], 06:28:25 INFO - 'tests': ['tsvgm']}}, 06:28:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:28:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:28:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:28:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 06:28:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:28:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:28:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:25 INFO - 'talos_options': ['--e10s'], 06:28:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:28:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:25 INFO - 'tests': ['damp', 'tps']}, 06:28:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:25 INFO - 'talos_options': ['--e10s'], 06:28:25 INFO - 'tests': ['damp', 'tps']}, 06:28:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:28:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:28:25 INFO - 'other': {'tests': ['a11yr', 06:28:25 INFO - 'ts_paint', 06:28:25 INFO - 'tpaint', 06:28:25 INFO - 'sessionrestore', 06:28:25 INFO - 'sessionrestore_no_auto_restore', 06:28:25 INFO - 'tabpaint']}, 06:28:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:28:25 INFO - 'tests': ['a11yr', 06:28:25 INFO - 'ts_paint', 06:28:25 INFO - 'tpaint', 06:28:25 INFO - 'sessionrestore', 06:28:25 INFO - 'sessionrestore_no_auto_restore', 06:28:25 INFO - 'tabpaint']}, 06:28:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:28:25 INFO - 'tests': ['a11yr', 06:28:25 INFO - 'ts_paint', 06:28:25 INFO - 'tpaint', 06:28:25 INFO - 'sessionrestore', 06:28:25 INFO - 'sessionrestore_no_auto_restore', 06:28:25 INFO - 'tabpaint']}, 06:28:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:28:25 INFO - 'tests': ['a11yr', 06:28:25 INFO - 'ts_paint', 06:28:25 INFO - 'tpaint', 06:28:25 INFO - 'sessionrestore', 06:28:25 INFO - 'sessionrestore_no_auto_restore', 06:28:25 INFO - 'tabpaint']}, 06:28:25 INFO - 'other_l64': {'tests': ['a11yr', 06:28:25 INFO - 'ts_paint', 06:28:25 INFO - 'tpaint', 06:28:25 INFO - 'sessionrestore', 06:28:25 INFO - 'sessionrestore_no_auto_restore', 06:28:25 INFO - 'tabpaint']}, 06:28:25 INFO - 'other_nol64': {'tests': ['a11yr', 06:28:25 INFO - 'ts_paint', 06:28:25 INFO - 'tpaint', 06:28:25 INFO - 'sessionrestore', 06:28:25 INFO - 'sessionrestore_no_auto_restore', 06:28:25 INFO - 'tabpaint']}, 06:28:25 INFO - 'svgr': {'tests': ['tsvgx', 06:28:25 INFO - 'tsvgr_opacity', 06:28:25 INFO - 'tart', 06:28:25 INFO - 'tscrollx', 06:28:25 INFO - 'cart']}, 06:28:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:28:25 INFO - 'tests': ['tsvgx', 06:28:25 INFO - 'tsvgr_opacity', 06:28:25 INFO - 'tart', 06:28:25 INFO - 'tscrollx', 06:28:25 INFO - 'cart']}, 06:28:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:25 INFO - 'tests': ['tp5o']}, 06:28:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:25 INFO - 'talos_options': ['--e10s'], 06:28:25 INFO - 'tests': ['tp5o']}, 06:28:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:25 INFO - 'talos_options': ['--xperf_path', 06:28:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:25 INFO - 'tests': ['tp5n']}, 06:28:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:28:25 INFO - 'talos_options': ['--e10s', 06:28:25 INFO - '--xperf_path', 06:28:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:28:25 INFO - 'tests': ['tp5n']}}, 06:28:25 INFO - 'talos.zip': {'path': '', 06:28:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:28:25 INFO - Running post-action listener: _resource_record_post_action 06:28:25 INFO - ##### 06:28:25 INFO - ##### Running create-virtualenv step. 06:28:25 INFO - ##### 06:28:25 INFO - Running pre-action listener: _resource_record_pre_action 06:28:25 INFO - Running main action method: create_virtualenv 06:28:25 INFO - Creating virtualenv /builds/slave/test/build/venv 06:28:25 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 06:28:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:28:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:28:25 INFO - Using real prefix '/tools/python27' 06:28:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:28:25 INFO - Installing distribute.............................................................................................................................................................................................done. 06:28:28 INFO - Installing pip.................done. 06:28:28 INFO - Return code: 0 06:28:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x10e2b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590586b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:28:28 INFO - Running command: ['/builds/slave/test/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/build 06:28:28 INFO - Copy/paste: /builds/slave/test/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 06:28:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:28:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:28 INFO - 'HOME': '/Users/cltbld', 06:28:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:28 INFO - 'LOGNAME': 'cltbld', 06:28:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:28 INFO - 'MOZ_NO_REMOTE': '1', 06:28:28 INFO - 'NO_EM_RESTART': '1', 06:28:28 INFO - 'PAGER': '/bin/cat', 06:28:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:28 INFO - 'PWD': '/builds/slave/test', 06:28:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:28 INFO - 'SHELL': '/bin/bash', 06:28:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:28:28 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:28:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:28 INFO - 'USER': 'cltbld', 06:28:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:28 INFO - 'XPC_FLAGS': '0x0', 06:28:28 INFO - 'XPC_SERVICE_NAME': '0', 06:28:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:29 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 06:28:29 INFO - Cleaning up... 06:28:29 INFO - Return code: 0 06:28:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x10e2b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590586b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:28:29 INFO - Running command: ['/builds/slave/test/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/build 06:28:29 INFO - Copy/paste: /builds/slave/test/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 06:28:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:28:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:29 INFO - 'HOME': '/Users/cltbld', 06:28:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:29 INFO - 'LOGNAME': 'cltbld', 06:28:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:29 INFO - 'MOZ_NO_REMOTE': '1', 06:28:29 INFO - 'NO_EM_RESTART': '1', 06:28:29 INFO - 'PAGER': '/bin/cat', 06:28:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:29 INFO - 'PWD': '/builds/slave/test', 06:28:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:29 INFO - 'SHELL': '/bin/bash', 06:28:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:28:29 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:28:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:29 INFO - 'USER': 'cltbld', 06:28:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:29 INFO - 'XPC_FLAGS': '0x0', 06:28:29 INFO - 'XPC_SERVICE_NAME': '0', 06:28:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:29 INFO - Downloading/unpacking psutil>=0.7.1 06:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:28:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:32 INFO - Installing collected packages: psutil 06:28:32 INFO - Running setup.py install for psutil 06:28:32 INFO - building 'psutil._psutil_osx' extension 06:28:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 06:28:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 06:28:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 06:28:32 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 06:28:32 INFO - building 'psutil._psutil_posix' extension 06:28:32 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 06:28:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:28:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:28:33 INFO - ^ 06:28:33 INFO - 1 warning generated. 06:28:33 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 06:28:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:28:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:28:33 INFO - Successfully installed psutil 06:28:33 INFO - Cleaning up... 06:28:33 INFO - Return code: 0 06:28:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:28: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')]} 06:28:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28: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')]} 06:28:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x10e2b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590586b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:28:33 INFO - Running command: ['/builds/slave/test/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/build 06:28:33 INFO - Copy/paste: /builds/slave/test/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 06:28:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:28:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:33 INFO - 'HOME': '/Users/cltbld', 06:28:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:33 INFO - 'LOGNAME': 'cltbld', 06:28:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:33 INFO - 'MOZ_NO_REMOTE': '1', 06:28:33 INFO - 'NO_EM_RESTART': '1', 06:28:33 INFO - 'PAGER': '/bin/cat', 06:28:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:33 INFO - 'PWD': '/builds/slave/test', 06:28:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:33 INFO - 'SHELL': '/bin/bash', 06:28:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:28:33 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:28:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:33 INFO - 'USER': 'cltbld', 06:28:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:33 INFO - 'XPC_FLAGS': '0x0', 06:28:33 INFO - 'XPC_SERVICE_NAME': '0', 06:28:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:28:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:28:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 06:28:36 INFO - Installing collected packages: mozsystemmonitor 06:28:36 INFO - Running setup.py install for mozsystemmonitor 06:28:36 INFO - Successfully installed mozsystemmonitor 06:28:36 INFO - Cleaning up... 06:28:36 INFO - Return code: 0 06:28:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:28:36 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')]} 06:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:36 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')]} 06:28:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x10e2b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590586b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:28:36 INFO - Running command: ['/builds/slave/test/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/build 06:28:36 INFO - Copy/paste: /builds/slave/test/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 06:28:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:28:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:36 INFO - 'HOME': '/Users/cltbld', 06:28:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:36 INFO - 'LOGNAME': 'cltbld', 06:28:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:36 INFO - 'MOZ_NO_REMOTE': '1', 06:28:36 INFO - 'NO_EM_RESTART': '1', 06:28:36 INFO - 'PAGER': '/bin/cat', 06:28:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:36 INFO - 'PWD': '/builds/slave/test', 06:28:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:36 INFO - 'SHELL': '/bin/bash', 06:28:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:28:36 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:28:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:36 INFO - 'USER': 'cltbld', 06:28:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:36 INFO - 'XPC_FLAGS': '0x0', 06:28:36 INFO - 'XPC_SERVICE_NAME': '0', 06:28:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:36 INFO - Downloading/unpacking blobuploader==1.2.4 06:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:38 INFO - Downloading blobuploader-1.2.4.tar.gz 06:28:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:28:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28: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 06:28:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:28:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:28:39 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 06:28:39 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 06:28:39 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 06:28:39 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 06:28:39 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 06:28:39 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 06:28:40 INFO - Downloading docopt-0.6.1.tar.gz 06:28:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:28:40 INFO - Installing collected packages: blobuploader, requests, docopt 06:28:40 INFO - Running setup.py install for blobuploader 06:28:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:28:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:28:40 INFO - Running setup.py install for requests 06:28:40 INFO - Running setup.py install for docopt 06:28:40 INFO - Successfully installed blobuploader requests docopt 06:28:40 INFO - Cleaning up... 06:28:41 INFO - Return code: 0 06:28:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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 0x10e2b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590586b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:28:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 06:28:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/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 06:28:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:28:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:41 INFO - 'HOME': '/Users/cltbld', 06:28:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:41 INFO - 'LOGNAME': 'cltbld', 06:28:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:41 INFO - 'MOZ_NO_REMOTE': '1', 06:28:41 INFO - 'NO_EM_RESTART': '1', 06:28:41 INFO - 'PAGER': '/bin/cat', 06:28:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:41 INFO - 'PWD': '/builds/slave/test', 06:28:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:41 INFO - 'SHELL': '/bin/bash', 06:28:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:28:41 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:28:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:41 INFO - 'USER': 'cltbld', 06:28:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:41 INFO - 'XPC_FLAGS': '0x0', 06:28:41 INFO - 'XPC_SERVICE_NAME': '0', 06:28:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:41 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-2syMKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:41 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-1vYNnR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:41 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-qlZ4GE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:41 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-hfscWq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:41 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-3NZF3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:41 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-p9OftA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:41 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-8UMtxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-s9ENoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-7Hdf1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-uQsNvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-8F9BcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-gVauR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-teedtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-H_9hmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-OpIIJF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-mx6Y5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:42 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-m9gOMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:43 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:28:43 INFO - Running setup.py install for manifestparser 06:28:43 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:28:43 INFO - Running setup.py install for mozcrash 06:28:43 INFO - Running setup.py install for mozdebug 06:28:43 INFO - Running setup.py install for mozdevice 06:28:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:28:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:28:43 INFO - Running setup.py install for mozfile 06:28:43 INFO - Running setup.py install for mozhttpd 06:28:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:28:43 INFO - Running setup.py install for mozinfo 06:28:44 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Running setup.py install for mozInstall 06:28:44 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Running setup.py install for mozleak 06:28:44 INFO - Running setup.py install for mozlog 06:28:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Running setup.py install for moznetwork 06:28:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Running setup.py install for mozprocess 06:28:44 INFO - Running setup.py install for mozprofile 06:28:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:28:44 INFO - Running setup.py install for mozrunner 06:28:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:28:45 INFO - Running setup.py install for mozscreenshot 06:28:45 INFO - Running setup.py install for moztest 06:28:45 INFO - Running setup.py install for mozversion 06:28:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:28:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:28:45 INFO - Cleaning up... 06:28:45 INFO - Return code: 0 06:28:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:28:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x10e2b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590586b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:28:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/config 06:28:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 06:28:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:28:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:45 INFO - 'HOME': '/Users/cltbld', 06:28:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:45 INFO - 'LOGNAME': 'cltbld', 06:28:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:45 INFO - 'MOZ_NO_REMOTE': '1', 06:28:45 INFO - 'NO_EM_RESTART': '1', 06:28:45 INFO - 'PAGER': '/bin/cat', 06:28:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:45 INFO - 'PWD': '/builds/slave/test', 06:28:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:45 INFO - 'SHELL': '/bin/bash', 06:28:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:28:45 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:28:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:45 INFO - 'USER': 'cltbld', 06:28:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:45 INFO - 'XPC_FLAGS': '0x0', 06:28:45 INFO - 'XPC_SERVICE_NAME': '0', 06:28:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:28:45 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-s_hLWk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:28:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 06:28:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:28:45 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-8lEzMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:28:46 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-7pifLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:28:46 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-ZlP15m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:28:46 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-MnLwxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:28:46 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-nJ2Mcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:28:46 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-x8BfDq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:28:46 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-UIThhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:28:46 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-oQCvAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:28:46 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-bSog2f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:28:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:28:46 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-JTvJUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:28:47 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-uXDbxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:28:47 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-RxEgyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:28:47 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-fxMdY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:47 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-Hj8tys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:28:47 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-0D9cDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 06:28:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:28:47 INFO - Running setup.py (path:/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/pip-rG1Po7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:28:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 06:28:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:28:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:28:50 INFO - Downloading blessings-1.6.tar.gz 06:28:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:28:50 INFO - Installing collected packages: blessings 06:28:50 INFO - Running setup.py install for blessings 06:28:50 INFO - Successfully installed blessings 06:28:50 INFO - Cleaning up... 06:28:50 INFO - Return code: 0 06:28:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:28:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:50 INFO - Reading from file tmpfile_stdout 06:28:50 INFO - Current package versions: 06:28:50 INFO - blessings == 1.6 06:28:50 INFO - blobuploader == 1.2.4 06:28:50 INFO - docopt == 0.6.1 06:28:50 INFO - manifestparser == 1.1 06:28:50 INFO - mozInstall == 1.12 06:28:50 INFO - mozcrash == 0.17 06:28:50 INFO - mozdebug == 0.1 06:28:50 INFO - mozdevice == 0.48 06:28:50 INFO - mozfile == 1.2 06:28:50 INFO - mozhttpd == 0.7 06:28:50 INFO - mozinfo == 0.9 06:28:50 INFO - mozleak == 0.1 06:28:50 INFO - mozlog == 3.1 06:28:50 INFO - moznetwork == 0.27 06:28:50 INFO - mozprocess == 0.22 06:28:50 INFO - mozprofile == 0.28 06:28:50 INFO - mozrunner == 6.11 06:28:50 INFO - mozscreenshot == 0.1 06:28:50 INFO - mozsystemmonitor == 0.0 06:28:50 INFO - moztest == 0.7 06:28:50 INFO - mozversion == 1.4 06:28:50 INFO - psutil == 3.1.1 06:28:50 INFO - requests == 1.2.3 06:28:50 INFO - wsgiref == 0.1.2 06:28:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:28:50 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')]} 06:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:50 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')]} 06:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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 0x10e2b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590586b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:28:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/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/build/tests/talos 06:28:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/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 06:28:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:28:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:50 INFO - 'HOME': '/Users/cltbld', 06:28:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:50 INFO - 'LOGNAME': 'cltbld', 06:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:50 INFO - 'MOZ_NO_REMOTE': '1', 06:28:50 INFO - 'NO_EM_RESTART': '1', 06:28:50 INFO - 'PAGER': '/bin/cat', 06:28:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:50 INFO - 'PWD': '/builds/slave/test', 06:28:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:50 INFO - 'SHELL': '/bin/bash', 06:28:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:28:50 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:28:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:50 INFO - 'USER': 'cltbld', 06:28:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:50 INFO - 'XPC_FLAGS': '0x0', 06:28:50 INFO - 'XPC_SERVICE_NAME': '0', 06:28:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 06:28:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 06:28:50 INFO - Cleaning up... 06:28:50 INFO - Return code: 0 06:28:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:28:50 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')]} 06:28:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:50 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')]} 06:28:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x10e2b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590586b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:28:50 INFO - Running command: ['/builds/slave/test/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/build 06:28:50 INFO - Copy/paste: /builds/slave/test/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 06:28:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:28:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:50 INFO - 'HOME': '/Users/cltbld', 06:28:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:50 INFO - 'LOGNAME': 'cltbld', 06:28:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:50 INFO - 'MOZ_NO_REMOTE': '1', 06:28:50 INFO - 'NO_EM_RESTART': '1', 06:28:50 INFO - 'PAGER': '/bin/cat', 06:28:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:50 INFO - 'PWD': '/builds/slave/test', 06:28:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:50 INFO - 'SHELL': '/bin/bash', 06:28:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:28:50 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:28:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:50 INFO - 'USER': 'cltbld', 06:28:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:50 INFO - 'XPC_FLAGS': '0x0', 06:28:50 INFO - 'XPC_SERVICE_NAME': '0', 06:28:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:51 INFO - Downloading/unpacking jsonschema 06:28:51 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 06:28:51 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 06:28:51 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 06:28:51 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 06:28:51 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 06:28:51 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 06:28:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:28:53 INFO - Downloading/unpacking functools32 (from jsonschema) 06:28:53 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 06:28:53 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 06:28:53 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 06:28:53 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 06:28:53 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 06:28:53 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 06:28:53 INFO - Downloading functools32-3.2.3-2.tar.gz 06:28:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:28:54 INFO - warning: no files found matching '*.txt' 06:28:54 INFO - no previously-included directories found matching 'build' 06:28:54 INFO - no previously-included directories found matching 'dist' 06:28:54 INFO - no previously-included directories found matching '.git*' 06:28:54 INFO - Installing collected packages: jsonschema, functools32 06:28:54 INFO - Running setup.py install for functools32 06:28:54 INFO - warning: no files found matching '*.txt' 06:28:54 INFO - no previously-included directories found matching 'build' 06:28:54 INFO - no previously-included directories found matching 'dist' 06:28:54 INFO - no previously-included directories found matching '.git*' 06:28:54 INFO - Successfully installed jsonschema functools32 06:28:54 INFO - Cleaning up... 06:28:54 INFO - Return code: 0 06:28:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 06:28:54 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')]} 06:28:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:28:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:54 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')]} 06:28:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:28:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:28:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/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 0x10e2b1a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2b84c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd590586b30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 06:28:54 INFO - Running command: ['/builds/slave/test/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/build 06:28:54 INFO - Copy/paste: /builds/slave/test/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 06:28:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:28:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:28:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:28:54 INFO - 'HOME': '/Users/cltbld', 06:28:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:28:54 INFO - 'LOGNAME': 'cltbld', 06:28:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:28:54 INFO - 'MOZ_NO_REMOTE': '1', 06:28:54 INFO - 'NO_EM_RESTART': '1', 06:28:54 INFO - 'PAGER': '/bin/cat', 06:28:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:28:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:28:54 INFO - 'PWD': '/builds/slave/test', 06:28:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:28:54 INFO - 'SHELL': '/bin/bash', 06:28:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:28:54 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:28:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:28:54 INFO - 'USER': 'cltbld', 06:28:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:28:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:28:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:28:54 INFO - 'XPC_FLAGS': '0x0', 06:28:54 INFO - 'XPC_SERVICE_NAME': '0', 06:28:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:28:54 INFO - Downloading/unpacking flake8 06:28:54 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 06:28:54 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 06:28:54 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 06:28:54 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 06:28:54 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 06:28:54 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 06:28:57 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 06:28:57 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 06:28:57 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:57 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 06:28:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 06:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:58 INFO - no previously-included directories found matching 'docs/_build' 06:28:58 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 06:28:58 INFO - Running setup.py install for pep8 06:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 06:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 06:28:58 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 06:28:58 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 06:28:58 INFO - no previously-included directories found matching 'docs/_build' 06:28:58 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 06:28:58 INFO - Successfully installed flake8 mccabe pyflakes pep8 06:28:58 INFO - Cleaning up... 06:28:58 INFO - Return code: 0 06:28:58 INFO - Running post-action listener: _resource_record_post_action 06:28:58 INFO - Running post-action listener: _start_resource_monitoring 06:28:58 INFO - Starting resource monitoring. 06:28:58 INFO - ##### 06:28:58 INFO - ##### Running install step. 06:28:58 INFO - ##### 06:28:58 INFO - Running pre-action listener: _resource_record_pre_action 06:28:58 INFO - Running main action method: install 06:28:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:28:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:28:59 INFO - Reading from file tmpfile_stdout 06:28:59 INFO - Detecting whether we're running mozinstall >=1.0... 06:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:28:59 INFO - Reading from file tmpfile_stdout 06:28:59 INFO - Output received: 06:28:59 INFO - Usage: mozinstall [options] installer 06:28:59 INFO - Options: 06:28:59 INFO - -h, --help show this help message and exit 06:28:59 INFO - -d DEST, --destination=DEST 06:28:59 INFO - Directory to install application into. [default: 06:28:59 INFO - "/builds/slave/test"] 06:28:59 INFO - --app=APP Application being installed. [default: firefox] 06:28:59 INFO - mkdir: /builds/slave/test/build/application 06:28:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 06:28:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 06:29:21 INFO - Reading from file tmpfile_stdout 06:29:21 INFO - Output received: 06:29:21 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 06:29:21 INFO - Running post-action listener: _resource_record_post_action 06:29:21 INFO - ##### 06:29:21 INFO - ##### Running run-tests step. 06:29:21 INFO - ##### 06:29:21 INFO - Running pre-action listener: _resource_record_pre_action 06:29:21 INFO - Running main action method: run_tests 06:29:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:29:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:29:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:29:21 INFO - 2016-06-06 06:29:21.554 screenresolution[1980:13016] starting screenresolution argv=screenresolution get 06:29:21 INFO - 2016-06-06 06:29:21.557 screenresolution[1980:13016] Display 0: 1600x1200x32@60 06:29:21 INFO - 2016-06-06 06:29:21.562 screenresolution[1981:13018] starting screenresolution argv=screenresolution list 06:29:21 INFO - Available Modes on Display 0 06:29:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:29:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:29:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:29:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:29:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:29:21 INFO - Intel Iris: 06:29:21 INFO - Chipset Model: Intel Iris 06:29:21 INFO - Type: GPU 06:29:21 INFO - Bus: Built-In 06:29:21 INFO - VRAM (Dynamic, Max): 1536 MB 06:29:21 INFO - Vendor: Intel (0x8086) 06:29:21 INFO - Device ID: 0x0a2e 06:29:21 INFO - Revision ID: 0x0009 06:29:21 INFO - Displays: 06:29:21 INFO - Display: 06:29:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:29:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:29:21 INFO - Display Serial Number: 1600x1200 60 06:29:21 INFO - Main Display: Yes 06:29:21 INFO - Mirror: Off 06:29:21 INFO - Online: Yes 06:29:21 INFO - Rotation: Supported 06:29:21 INFO - Return code: 0 06:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:29:21 INFO - Python 2.7.3 06:29:21 INFO - Return code: 0 06:29:21 INFO - grabbing minidump binary from tooltool 06:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:29:21 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/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e155d30>, '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 0x10dfb9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e14cb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:29:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 06:29:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 06:29:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:29:21 INFO - Return code: 0 06:29:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:29:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:29:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:29:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:29:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:29:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 06:29:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 06:29:23 INFO - Return code: 0 06:29:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 06:29:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0022 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 06:29:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kOffrYcyn6/Render', 06:29:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:29:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:29:23 INFO - 'HOME': '/Users/cltbld', 06:29:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:29:23 INFO - 'LOGNAME': 'cltbld', 06:29:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:29:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:29:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:29:23 INFO - 'MOZ_NO_REMOTE': '1', 06:29:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:29:23 INFO - 'NO_EM_RESTART': '1', 06:29:23 INFO - 'PAGER': '/bin/cat', 06:29:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:29:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:29:23 INFO - 'PWD': '/builds/slave/test', 06:29:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:29:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:29:23 INFO - 'SHELL': '/bin/bash', 06:29:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners', 06:29:23 INFO - 'TMPDIR': '/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/', 06:29:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:29:23 INFO - 'USER': 'cltbld', 06:29:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:29:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:29:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:29:23 INFO - 'XPC_FLAGS': '0x0', 06:29:23 INFO - 'XPC_SERVICE_NAME': '0', 06:29:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:29:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0022', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 06:29:23 INFO - mozversion application_buildid: 20160603143526 06:29:23 INFO - mozversion application_changeset: a86835580095325bf5c85483fad952f5c99d973e 06:29:23 INFO - mozversion application_display_name: Firefox 06:29:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:29:23 INFO - mozversion application_name: Firefox 06:29:23 INFO - mozversion application_remotingname: firefox 06:29:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 06:29:23 INFO - mozversion application_vendor: Mozilla 06:29:23 INFO - mozversion application_version: 47.0 06:29:23 INFO - mozversion platform_buildid: 20160603143526 06:29:23 INFO - mozversion platform_changeset: a86835580095325bf5c85483fad952f5c99d973e 06:29:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 06:29:23 INFO - mozversion platform_version: 47.0 06:29:23 INFO - using testdate: 1465219763 06:29:23 INFO - actual date: 1465219763 06:29:23 INFO - starting webserver on 'localhost:51340' 06:29:23 INFO - SUITE-START | Running 2 tests 06:29:23 INFO - TEST-START | dromaeo_css 06:29:23 INFO - operating with platform_type : mac_ 06:29:23 INFO - Initialising browser for dromaeo_css test... 06:29:23 INFO - TEST-INFO | started process 1999 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/tmpLlVNdq/profile http://localhost:51340/getInfo.html) 06:29:25 INFO - PROCESS | 1999 | __metrics Screen width/height:1600/1200 06:29:25 INFO - PROCESS | 1999 | colorDepth:24 06:29:25 INFO - PROCESS | 1999 | Browser inner width/height: 1024/689 06:29:25 INFO - PROCESS | 1999 | __metrics 06:29:25 INFO - PROCESS | 1999 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:29:25 INFO - PROCESS | 1999 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:29:26 INFO - TEST-INFO | 1999: exit 0 06:29:26 INFO - Browser initialized. 06:29:26 INFO - Running cycle 1/1 for dromaeo_css test... 06:29:26 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/tmpLlVNdq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:38 INFO - PROCESS | 2001 | RSS: Main: 157310976 06:29:38 INFO - PROCESS | 2001 | 06:30:29 INFO - PROCESS | 2001 | 1465219829816 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] 06:32:38 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51340/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51340/tests/dromaeo/cssquery-ext.html) 06:32:40 INFO - PROCESS | 2001 | RSS: Main: 298323968 06:32:40 INFO - PROCESS | 2001 | 06:35:42 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51340/tests/dromaeo/cssquery-ext.html (next: http://localhost:51340/tests/dromaeo/cssquery-jquery.html) 06:35:43 INFO - PROCESS | 2001 | RSS: Main: 290127872 06:35:43 INFO - PROCESS | 2001 | 06:38:45 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51340/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51340/tests/dromaeo/cssquery-mootools.html) 06:38:45 INFO - PROCESS | 2001 | RSS: Main: 296607744 06:38:45 INFO - PROCESS | 2001 | 06:41:47 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51340/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51340/tests/dromaeo/cssquery-prototype.html) 06:41:48 INFO - PROCESS | 2001 | RSS: Main: 256860160 06:41:48 INFO - PROCESS | 2001 | 06:44:51 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51340/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51340/tests/dromaeo/cssquery-yui.html) 06:44:51 INFO - PROCESS | 2001 | RSS: Main: 257630208 06:44:51 INFO - PROCESS | 2001 | 06:47:54 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:51340/tests/dromaeo/cssquery-yui.html (next: http://localhost:51340/tests/dromaeo/cssquery-dojo.html) 06:47:54 INFO - PROCESS | 2001 | RSS: Main: 304050176 06:47:54 INFO - PROCESS | 2001 | 06:47:54 INFO - PROCESS | 2001 | __start_tp_report 06:47:54 INFO - PROCESS | 2001 | _x_x_mozilla_page_load 06:47:54 INFO - PROCESS | 2001 | _x_x_mozilla_page_load_details 06:47:54 INFO - PROCESS | 2001 | |i|pagename|runs| 06:47:54 INFO - PROCESS | 2001 | |0;dojo.html;3034.0291106845802;3624.9093772655697;3627.7618200431352;3646.507721457604;3705.833237504312;5934.050551911695;5962.433568810961;5963.433473819986;5976.223090998175;6021.217241758571;5900.88198236035;5955.821325360246;5968.19429377034;5969.074793407018;5982.521398288127;5205.557527610158;5282.313299271099;5325.520703136717;5399.082156033464;5421.864453388657;5394.163904594794;5439.075357189267;5442.12925931851;5443.047466693313;5443.972780136094;5329.173978033411;5386.245925570423;5396.91904621431;5402.000629883464;5408.756605952742;5390.21841832934;5400.000999815027;5405.675659460445;5429.104197807357;5481.835544933659;5178.14560597501;5333.306670132897;5339.70631615261;5360.9463905360835;5393.568514518829;5750.223719797816;5750.539956803445;5768.625039372428;5795.1017592273265;5816.970915145397;6156.076588511714;6287.1198032275515;6295.622262664209;6300.21247344082;6301.936980630181;6236.532260080512;6249.812505624838;6253.656048917308;6263.467605253559;6270.184875966141;6008.879822403571;6076.787312444043;6081;6102.26772787264;6103.511719062509;6257.499400047986;6271.905921411182;6285.214348206474;6295.055741638699;6296.622202667854;6073.423024812636;6127.080937859357;6177.505799536027;6185;6232.096346029891;6294.464970477561;6309.211348581427;6326.051092336186;6349.777757778548;6351.047342898602;6242.687865606701;6268.843278917972;6292.244930608264;6294.748210071637;6297.527685423612;6209.5032397408095;6210.968945155245;6301.212348456443;6308.653024083719;6315.179026726496;5017.37282839645;5034.345535080416;5047.697138171648;5049.722265275372;5049.974750126299;4536.6824322297125;4545.3863728396245;4567.018091110361;4568.314752787042;4587.013792034729;6039.912815693217;6053.939460605426;6054.878902422015;6064.727087281083;6071.908921366183;6225.408586184305;6227.937720622826;6229.408206220402;6230.43926046658;6291.245050593958;6073;6077.574569780073;6086.482648974798;6092.51259899207;6114.633122012693;5523.337199536001;5532.280803495601;5549.1676248562235;5550.250716153349;5550.750216240279;5554.750036248379;6289.968550157311;6422.935770642233;6531.3142120077655;6533.705983230861;6264.467520260647;6266.279377871603;6269.49844012487;6288.465480434214;6309.085182648582;6497.480201583957;6520.380563846427;6533.41199292066;6553.705083271169;6578.342165783383;6168.414000669929;6202.472789812917;6257.499400047895;6289;6297.811065668037;6238.937610623836;6248.281447633581;6254.906176407267;6258.780942666985;6278.46633036197;6111.926012480351;6201.162843016135;6261.624302541862;6282.654454004891;6286.4342209201395;6158.969205153946;6241.96879015602;6242.843928901813;6267.96866015667;6282.183316168869;6104.8779024420155;6130.846728831815;6132.264128304632;6161.014237722122;6169.105479705508;6118.527810132385;6189.659568723763;6286.685665716787;6292.590981586182;6309.652969086745;6030.5778595497895;6109.1010297800785;6137.591499645514;6142.867137759686;6146.340488068286 06:47:54 INFO - PROCESS | 2001 | |1;ext.html;495.5341978540174;575.9373955052926;598.7934312360592;676.28989560961;681.7886455198887;40624.39063414047;41191.79404102979;41223.38164927521;41344.58655413445;41363.75908722743;44380.556194438046;45001.324980125326;45025.7748711256;45056.0988780225;45215;9724.416535007904;9966.402015879034;9967.252456065788;9978.101970822625;9988.152191844532;9797.363171393872;9963.053509916546;9995.100440960312;10002.199824014098;10006.449645269508;9953.800923981516;10038.749031274203;10040.347377420481;10041.849372259421;10046.095851373375;9927.503624818766;10018.549165287579;10034.197264218845;10035.448050357227;10040.945700701432;9818.90181098187;9937.453440060794;9948.10467057961;9949.850752238723;9950.900490995069;43152;43774.78112609449;43801;43805.780971094944;43880.78059609682;3410.2838403934957;3551.8401671924566;3555.8933232003083;3963.989182758407;4007.579204183577;28845.85577072122;29445.263868403246;29572.964946226777;30482;31324.21689457759;2741.7669498092687;2786.5680819473014;2820.4077143799623;2853.1297954123984;2896.869640866145;500720;501228.99999999633;501802;501942;501971;48675.75662121738;49621.25568116481;49681.75159124254;49798.75100624474;71924;40927.795361023;48563.75718121387;48676;48748;48790.512094879305;16889.408870689465;17072.743908841378;17082.743758843626;17087.487375378758;17104;13511.729765404636;13613.251271179983;13626.727465450835;13641.590752277447;13880.722385552433;13231.66920826987;15699.607509812346;15731.528054158394;15766.842331576538;15868.841311586737;6469.838254043687;6555.672216389162;6627.4366678831875;6630.502712296597;6631.668416579152;946.6402766948515;1009.2783659683215;1056.984145237822;1060.2684147937898;1095.1348434736628;31334;32630.673693263238;33228;33432;33751.83124084413;1079.1798233342558;1079.4926384599225;1112.4826955465746;1143.4225716013527;1159.3449700919123;11874.406279685982;13220.537281195113;14003;16835.242414091394;16984.74522882158;680507;703068;703692;703814;705343;64775.02837457442;65361.346386536476;65371.67314163399;65408;65420.01869971954;1487.9032862863878;1536.523677659929;1569.7409927362087;1601.071378600409;1605.1091644137616;29621.555676664437;30735.538966915963;31089.756409743357;31129.066128016195;31604;50216.497835022645;50554.988900222525;50839.49160508347;51024.489755101975;51035.74482127566;360373.396266034;360458;361084;362491;363408;30545;34818.65181348255;35350.46974295439;35604;35674.28651427009;50297;51016;51289.743551282;51533.227001595755;52962.735186325364;41900.161996759285;42968.92577685583;43341.34987975246;43385.13229735451;43979.560204398826;38587;40994.385084224356;41011;41844.37233441562;42169;42230;42375.94060148521;42690;42843.785781070896;43829;39815;41492.79253603713;41507.37738933858;42276.36585451159;42295.5770442304;24084;27112.068535639068;27812.721872781014;27902.3024424391;27915 06:47:54 INFO - PROCESS | 2001 | |2;jquery.html;334.40642858925406;394.93483575210075;395.27072551143146;396.42716274982655;400.60140160540266;16901.7464738029;16979.74530382045;20263;22262.332130036106;22747.317580472612;18818.435446936615;21479.55937326016;21610;22200.77799222011;22271.331860044185;5746.597738158331;5840.415958404157;5883.146943693162;5958.046712525997;5958.97020514899;4396.120775844828;5829.970850145764;5869.647821130725;6238.500919926395;6502.804915852532;6450.096986421905;6453.225612926455;6459.6447195404235;6459.806205813809;6462.063000864871;4963.255511673242;5798.884022319572;5988.640681559121;5999.880002399927;6419.871602567946;5703.971480142614;5711.200431939532;5714.914276285859;5722.799702010409;5728.083506638959;14562.635934101627;18682.06589670511;19974.400767976986;27131.864340678367;27162.864185678944;2083;2181.7490988536365;2187.3219302016428;2207.7461091974305;2341.7072865891764;9884.703458896245;10663.86722655472;11298.661040168809;11385.886141138566;15499.302531386114;1740.5126564561942;1742.2769550636472;1810.9818901810945;1830.1398342778873;1833.1109411935201;112538;115709;117186.8281317193;118668.40665796702;119749.20376194365;10350.275480716278;10912.23614347004;11437.968938231375;11508.251963622506;11668.241564298294;12686.555970540987;13126.212427254395;14463.059901106604;14536.781948270784;14558.927205363905;8668.696595619123;8951;8952.015278319379;8980;9044.186023257938;7545.660445279976;8977.236934860479;8981.191692747683;9131.26949844011;9370.39092458988;4512.503624601291;4528.50186479487;4528.547145285445;4534.455865296186;4587.931181032287;1851.879627824187;1908.1127275816534;1910.7802602700867;1911.5794525204433;1919.376202734117;916.3493919317226;1012.4785735346303;1038.99480502597;1086.22877756792;1087.9129669626411;20208;20386;20819.37541873746;21127;21434.678479822815;860.1957170046027;905.2667339455063;1003.2726273451689;1033.34382667007;1121.3944469986116;11299.661010169708;11369.658910232707;11387.20289579738;11398.487068081957;11477.196596238351;677747;688061;689251;690888;695972;123296;124740;127535;127888.08167877303;132571.33714331366;1099.5326986031064;1103.8951299626522;1115.7656892052598;1144.2791041643877;1155.0990227622467;18079.909600451912;18107.45677629673;18125.456236312933;18140.365087221882;18910.810891890906;50421.74789126031;52315.73842130765;52952.94094118173;53130.4686953141;53291.20063199133;74142.62928685322;75828.86256706264;76603;77091.61454192693;80100.19899800928;8165.755027349189;8237.670493180445;8246.793830154294;8393.622286996977;8433.620487078219;9547.809043819223;12895.41970611306;13086.672833179247;13530.458781648624;13620.591382258151;11187.993080622782;11431.199816013132;11693.415329233334;11745.47145378477;11749;11114.22200445961;11144.888551114385;11213.495392707184;11312.15158863072;11693.941530292293;11586.131040171853;11688;11855.822162667395;11983.28100313984;12075.396230188631;8158.551279679437;8159.347252219927;8198.098209196864;8298.751037468886;8548.358873084419;8841.115888411108;11383.829242561535;11877.46551405206;12010.75978480408;12034.699132521757 06:47:54 INFO - PROCESS | 2001 | |3;mootools.html;1512.1909778268625;1512.5159948816383;1685.5449028762234;2007.678771396576;2117.9894100529496;7941.642626081826;8319.625616847241;8964.641414343427;9148.954255228722;9478.478683672396;8777.078406767278;9022;9050.90949090509;9068.047854975232;9080.27357811375;2516.710578283498;2552.0940066276485;2555.1823416506727;2561.2700380391593;2561.70540387855;2434.573949558829;2569.2549160743456;2571.9742802572014;2577.059373328731;2583.3154214133174;2219.700340454034;2541.1106112860443;2575.446279050004;2576.987115064422;2592.468543948486;2540.276021333911;2556.4759224359054;2572.8842202100855;2583.715791262978;2589.935251618706;2539.517491676594;2561.564534029201;2565.3073670108965;2567.4865026994676;2582.6771653543306;8385.832283354299;8749.562521873944;8864.42381245217;9121.361504694607;9148.817023659556;5640.125780504029;5877.9412205877825;5883.0881213411985;5888.322842873039;5890.676012819294;3638;3733.290674771785;3747.063234191452;3747.4378843173467;3786.6402691744242;1089.4607169451172;1089.8801131875487;1090.6291860767299;1131.3777422417638;1131.7510147767478;12299.69250768729;12413.93793031029;12513.436895339823;12519.3740312984;12520.686982825411;4827.42070951481;4832.009438065188;4904.852854414374;4932.161532539477;4960.90078198434;9709.465979371062;9716.31985761004;9717.854232186522;9731.610735570639;9732.978037306122;5663.433656634304;5669.914951275734;5677.489025987681;5677.943220567741;5680.801171958961;4104.240715467588;4218.261804184255;4800.567948884617;5242.501962313574;5279.947200528022;3860.6718428933855;3897.279003384383;3957.149212919179;3971.2653159165648;3981.6217459341315;1236.7341021680381;1250.5373011985441;1255.7865162922326;1262.5707259531803;1265.73419581887;1423.5942756314607;1450.8766754825747;1466.6480044789387;1474.115530681604;1492.8507149284985;8553.61508732096;8597.742067737978;8617.310615150773;8672.60973256205;8683.652653893774;544.4147541393019;550.3121098626716;556.9443055694479;558.3941423555488;559.7956745787758;6438.903416448757;6448.258450278185;6521.9673901630185;6554.639494827735;6561.639109848908;11071.335719856834;11623.53505859773;11639.127065469955;11662.70843228926;11704.297742135499;11148.721281968015;11164.385958772345;11273.210875238654;11284.943575282236;11406.543738250377;8830.911690883137;8835.602397892111;8871.423357481743;8918.92972843263;8921.598528066123;8032.236937490929;8253.711120110767;8348.248657620601;8362.121977192308;8380.371472139492;9754;9759.316847820584;9790.951045244728;9846.753831154278;10089.09198172168;7848.450608457353;10385.948070259601;10436.791264174826;10457.529411176363;10469.476526173814;7020.543664661781;7225.494215405081;7486.588237646763;7540.057492813398;7661.961690191736;8419.452735572168;8430.030546487233;8478.57607119654;8480.83038339242;8510.276626486819;7468.5145465544565;7568.772936811904;7661.961690191736;7674.501157424749;7706.306432421109;7378.114626244885;7429.14564825052;7447.218042105501;7583.696652133853;7586.355159811478;7759.340456061298;8018.198180181935;8025.2777250047775;8034.83930321402;8035.919640803517;7186.209516953236;7196.388306993964;7222.96388518054;7281.672324745505;7298.927010729824;7377.446691498052;7383.372413344926;7427.554346739213;7431.256874312742;7442.627868606656 06:47:54 INFO - PROCESS | 2001 | |4;prototype.html;334.0696161191083;344.91204742790586;345.6716119686298;348.1591955427642;352.8182985762333;6504.47964162867;6519.511036672251;6536.901946470807;6550.377714117157;6563.245226798907;5233.607479439048;6472.7410903563805;6519.380658837415;6520.70656820443;6545.770898018571;4594.3338215958665;4683.133620280242;4759.071980963713;4886.951130488703;4898.877528061791;4193.266178418779;4672.696274742148;4815.735134567597;4885.145099607572;4894.53501917319;4151.481064866892;4753.691010084351;4856.3201151838775;4869.415670119591;4882.97558512207;4633.328167415722;4637.234856248715;4757.9286310705365;4791.401074865642;4798.160321943646;4081.0817566047403;4091.5499295077816;4093.5906409359122;4101.671866250693;4102.323116685743;6083.422074902877;6115.174451449042;6137.079438084278;6179.938200618026;6221.751129954796;5733.054046082391;5737.2254745609225;5738.225339579145;5741.483266505993;5741.799037033726;6823.55646882951;6833.487488438337;6847.144106986627;6865;6883.965580172117;4511.70673906195;4665.300204969248;4682.274247491644;4713.882152946169;4719.457262414832;6982.930170698279;7226.494145409823;7273.818154546126;7278.490505664606;7279.417646588313;4805.663603547788;4814.15752243356;4814.350062741555;4815.975920120377;4816.8795780105775;4863.3434486344595;4864.902701946012;4865.95134048655;4866.902661946741;4885.8045678172475;5759.1937128802;5761.711914404347;5763.242211125647;5766.826995190151;5779.33537643168;6685.6322902240845;6887.830333445049;6924.896126558106;6927.618980956096;6949.478789090838;1538.2001359293106;1684.107423065777;1696.7200411931892;1701.0304126647693;1701.2259421962976;1037.930931140926;1071.8338657508098;1097.8627671541058;1102.415719668577;1130.3895896216115;6486.578372405873;6651.833704157338;6671.966640166768;6681.365270299314;6690.163729533809;7221.783346499614;7250.9637451812405;7271.63641817907;7291.161516425573;7319.304666056716;6639.701213445406;6650.235222949326;6652;6671.366220209073;6685.39831415175;3691.2850667165208;3753.024213704402;3798.3163030654746;3806.143617686054;3808.143167787281;7445;7516.135644400964;7540.849183016309;7542.434317426105;7584.696612135453;6046.395360463918;7346.008288881039;7384.778456646309;7389.3349598535315;7389.81525461857;7466.514676546007;7469.879518072224;7479.401647868158;7492.7752167435065;7497.250274972568;5241.318628578413;6228.28374736893;7183.712651494091;7187.31720486553;7190.7483238086415;6311.337309582428;6699.464042876656;7066;7078.044463997295;7085.291470852873;7461.216572259835;7503.212162723054;7525.962370188114;7542.622868856645;7543;4840.975795121002;4847.466778654416;4847.903041939212;4848.5636292733825;4848.903021939612;7165.104361954755;7170.42636589082;7170.462215333767;7177.605231712306;7180.820479487846;6657.53397262187;6937.375636192565;6938.687759050956;6945.756898508528;6968.163820341591;5922.378150294157;6907.378335949788;6924.169099708067;6931.949942025492;6956.095707557985;6254.343293954252;6763.729450822108;6780.627065511444;6788.811957907247;6794.252632210551;6324.272708638381;6666.566673166229;6948.33990770876;6948.895766563607;6968.686409111703;5818.272715910512;6423.871522569429;6466.741330346734;6769.120014398293;6866.6566671667215 06:47:54 INFO - PROCESS | 2001 | |5;yui.html;775.768184553262;777.0481160578296;780.013283196756;804.4007214625105;805.7904944714372;15720.921395393021;15906.443274485395;15911.363545458167;15960.201989900517;15961.361545538193;14857.554273371788;14870.479533216312;14899.180545070018;14921.104733715985;14961.476348327811;806.6087947345533;811.772703642978;819.5902048975512;971.1502435369052;998.6255154317131;978.0757184460688;981.6122631560529;987.0869445762677;987.920966322696;987.9823781505062;1052.2213561964168;1058.1904842795268;1060.3213943076437;1060.8249638809586;1061.4215252687266;849.4478588917192;864.4424346296635;866.4801119328415;866.4887716247381;1034.4517405774952;791.6160662078887;792.0495405513407;792.5918152151589;792.817651940057;794.0550744613948;15464.922675386664;15530.456434024754;15538.766918496118;15539.611509712235;15566.610834729223;13540.59378218655;13699.246541440218;13924;14049.227292498908;14094.50669226572;10433.5826566938;10439.42583157926;10461.37231766089;10710.839337409945;11000.944995274973;3570.982145089284;3572.0304956031273;3659.6340365963456;3714.312852122339;3866.8259928303014;84656;86583.70124448139;87749.56125219334;88165.67751483797;88383;9793.853092203623;9844.556994935245;9880.802383952281;10046.899531004743;10661.946690266654;22007;22291.108355665918;22330.441738956655;22335.329940101823;22377.664335034988;7675.385969122457;7879.409044321699;8024.037115546172;8105.8378832424205;8112.716054938049;4085.22380747657;4209.852655157055;4310.956890431118;4412.580804823537;4579.015511664941;3796.905077373088;3804.505414296124;3809.8857034289017;3821.063839359375;3825.2349530094093;466.21442868766235;594.5451729426992;697.822055375876;704.9400800931876;706.6254884911006;564.9209110724502;626.37675512865;645.3353046362255;647.9902801457982;663.0882536512296;7969.402294827795;8522.062573116953;8610.569471526398;8670.78323041929;8904.181003023601;573.1717667969743;609.9451049405575;623.1276213301414;633.2812258087105;636.3572791480638;3906.746061505993;3936.7047471439755;4082.1223436961195;4116.938245926313;4248.022954720432;97186.5140674292;97589;98733.01266987382;99726;101699;81155.18844811595;82303.58848205721;83156.58421707853;83283;83297;75781.62109189529;75986;76231;76948;77195.22804771992;7964.6415911282975;8070.515769053875;8199.549024803455;8228.917710822816;8248.070364387013;51250.718732032;51801.963960721325;51807.40962951913;51891.740541297055;53487.73256133695;66755;74205.25794741983;74630.25369746234;75428.62285688757;76083.61958190173;10090.39457632515;10295.433751143759;10332.845007324746;10382.3251488653;10970.725731856448;11120.721981950515;11186.608468703556;11324.150688698215;11431.657050288504;12012.918837304685;10585.364878107339;10624.256302058782;10689.732756680834;10864.619738309122;11423.971842534213;9131.406458580437;10566.366018038942;10816.891831081588;11068.391238481961;11464.369459679798;10600.734981625521;10613.745311840305;10658.946705266424;11000.119990400908;11070.944645276722;8942.252715837725;9164.862527062232;9178.26573874075;9208.953955230449;9326.207272381653;7786.4938778979185;9179.357444978787;9190.632374704937;9206.907930920874;9436.339456238273 06:47:54 INFO - PROCESS | 2001 | __end_tp_report 06:47:54 INFO - PROCESS | 2001 | __start_cc_report 06:47:54 INFO - PROCESS | 2001 | _x_x_mozilla_cycle_collect,1221 06:47:54 INFO - PROCESS | 2001 | __end_cc_report 06:47:54 INFO - PROCESS | 2001 | __startTimestamp1465220874847__endTimestamp 06:47:54 INFO - PROCESS | 2001 | 06:47:54 INFO - PROCESS | 2001 | ------- Summary: start ------- 06:47:54 INFO - PROCESS | 2001 | Number of tests: 6 06:47:54 INFO - PROCESS | 2001 | 06:47:54 INFO - PROCESS | 2001 | [#0] dojo.html Cycles:165 Average:5881.81 Median:6127.08 stddev:615.68 (10.0%) stddev-sans-first:575.61 06:47:54 INFO - PROCESS | 2001 | Values: 3034.0 3624.9 3627.8 3646.5 3705.8 5934.1 5962.4 5963.4 5976.2 6021.2 5900.9 5955.8 5968.2 5969.1 5982.5 5205.6 5282.3 5325.5 5399.1 5421.9 5394.2 5439.1 5442.1 5443.0 5444.0 5329.2 5386.2 5396.9 5402.0 5408.8 5390.2 5400.0 5405.7 5429.1 5481.8 5178.1 5333.3 5339.7 5360.9 5393.6 5750.2 5750.5 5768.6 5795.1 5817.0 6156.1 6287.1 6295.6 6300.2 6301.9 6236.5 6249.8 6253.7 6263.5 6270.2 6008.9 6076.8 6081.0 6102.3 6103.5 6257.5 6271.9 6285.2 6295.1 6296.6 6073.4 6127.1 6177.5 6185.0 6232.1 6294.5 6309.2 6326.1 6349.8 6351.0 6242.7 6268.8 6292.2 6294.7 6297.5 6209.5 6211.0 6301.2 6308.7 6315.2 5017.4 5034.3 5047.7 5049.7 5050.0 4536.7 4545.4 4567.0 4568.3 4587.0 6039.9 6053.9 6054.9 6064.7 6071.9 6225.4 6227.9 6229.4 6230.4 6291.2 6073.0 6077.6 6086.5 6092.5 6114.6 5523.3 5532.3 5549.2 5550.3 5550.8 5554.8 6290.0 6422.9 6531.3 6533.7 6264.5 6266.3 6269.5 6288.5 6309.1 6497.5 6520.4 6533.4 6553.7 6578.3 6168.4 6202.5 6257.5 6289.0 6297.8 6238.9 6248.3 6254.9 6258.8 6278.5 6111.9 6201.2 6261.6 6282.7 6286.4 6159.0 6242.0 6242.8 6268.0 6282.2 6104.9 6130.8 6132.3 6161.0 6169.1 6118.5 6189.7 6286.7 6292.6 6309.7 6030.6 6109.1 6137.6 6142.9 6146.3 06:47:54 INFO - PROCESS | 2001 | 06:47:54 INFO - PROCESS | 2001 | [#1] ext.html Cycles:180 Average:66993.40 Median:41207.59 stddev:144114.65 (349.7%) stddev-sans-first:144432.44 06:47:54 INFO - PROCESS | 2001 | Values: 495.5 575.9 598.8 676.3 681.8 40624.4 41191.8 41223.4 41344.6 41363.8 44380.6 45001.3 45025.8 45056.1 45215.0 9724.4 9966.4 9967.3 9978.1 9988.2 9797.4 9963.1 9995.1 10002.2 10006.4 9953.8 10038.7 10040.3 10041.8 10046.1 9927.5 10018.5 10034.2 10035.4 10040.9 9818.9 9937.5 9948.1 9949.9 9950.9 43152.0 43774.8 43801.0 43805.8 43880.8 3410.3 3551.8 3555.9 3964.0 4007.6 28845.9 29445.3 29573.0 30482.0 31324.2 2741.8 2786.6 2820.4 2853.1 2896.9 500720.0 501229.0 501802.0 501942.0 501971.0 48675.8 49621.3 49681.8 49798.8 71924.0 40927.8 48563.8 48676.0 48748.0 48790.5 16889.4 17072.7 17082.7 17087.5 17104.0 13511.7 13613.3 13626.7 13641.6 13880.7 13231.7 15699.6 15731.5 15766.8 15868.8 6469.8 6555.7 6627.4 6630.5 6631.7 946.6 1009.3 1057.0 1060.3 1095.1 31334.0 32630.7 33228.0 33432.0 33751.8 1079.2 1079.5 1112.5 1143.4 1159.3 11874.4 13220.5 14003.0 16835.2 16984.7 680507.0 703068.0 703692.0 703814.0 705343.0 64775.0 65361.3 65371.7 65408.0 65420.0 1487.9 1536.5 1569.7 1601.1 1605.1 29621.6 30735.5 31089.8 31129.1 31604.0 50216.5 50555.0 50839.5 51024.5 51035.7 360373.4 360458.0 361084.0 362491.0 363408.0 30545.0 34818.7 35350.5 35604.0 35674.3 50297.0 51016.0 51289.7 51533.2 52962.7 41900.2 42968.9 43341.3 43385.1 43979.6 38587.0 40994.4 41011.0 41844.4 42169.0 42230.0 42375.9 42690.0 42843.8 43829.0 39815.0 41492.8 41507.4 42276.4 42295.6 24084.0 27112.1 27812.7 27902.3 27915.0 06:47:54 INFO - PROCESS | 2001 | 06:47:54 INFO - PROCESS | 2001 | [#2] jquery.html Cycles:180 Average:37437.46 Median:21280.84 stddev:114069.19 (536.0%) stddev-sans-first:114355.16 06:47:54 INFO - PROCESS | 2001 | Values: 334.4 394.9 395.3 396.4 400.6 16901.7 16979.7 20263.0 22262.3 22747.3 18818.4 21479.6 21610.0 22200.8 22271.3 5746.6 5840.4 5883.1 5958.0 5959.0 4396.1 5830.0 5869.6 6238.5 6502.8 6450.1 6453.2 6459.6 6459.8 6462.1 4963.3 5798.9 5988.6 5999.9 6419.9 5704.0 5711.2 5714.9 5722.8 5728.1 14562.6 18682.1 19974.4 27131.9 27162.9 2083.0 2181.7 2187.3 2207.7 2341.7 9884.7 10663.9 11298.7 11385.9 15499.3 1740.5 1742.3 1811.0 1830.1 1833.1 112538.0 115709.0 117186.8 118668.4 119749.2 10350.3 10912.2 11438.0 11508.3 11668.2 12686.6 13126.2 14463.1 14536.8 14558.9 8668.7 8951.0 8952.0 8980.0 9044.2 7545.7 8977.2 8981.2 9131.3 9370.4 4512.5 4528.5 4528.5 4534.5 4587.9 1851.9 1908.1 1910.8 1911.6 1919.4 916.3 1012.5 1039.0 1086.2 1087.9 20208.0 20386.0 20819.4 21127.0 21434.7 860.2 905.3 1003.3 1033.3 1121.4 11299.7 11369.7 11387.2 11398.5 11477.2 677747.0 688061.0 689251.0 690888.0 695972.0 123296.0 124740.0 127535.0 127888.1 132571.3 1099.5 1103.9 1115.8 1144.3 1155.1 18079.9 18107.5 18125.5 18140.4 18910.8 50421.7 52315.7 52952.9 53130.5 53291.2 74142.6 75828.9 76603.0 77091.6 80100.2 8165.8 8237.7 8246.8 8393.6 8433.6 9547.8 12895.4 13086.7 13530.5 13620.6 11188.0 11431.2 11693.4 11745.5 11749.0 11114.2 11144.9 11213.5 11312.2 11693.9 11586.1 11688.0 11855.8 11983.3 12075.4 8158.6 8159.3 8198.1 8298.8 8548.4 8841.1 11383.8 11877.5 12010.8 12034.7 06:47:54 INFO - PROCESS | 2001 | 06:47:54 INFO - PROCESS | 2001 | [#3] mootools.html Cycles:180 Average:6246.89 Median:5651.78 stddev:3326.52 (58.9%) stddev-sans-first:3316.82 06:47:54 INFO - PROCESS | 2001 | Values: 1512.2 1512.5 1685.5 2007.7 2118.0 7941.6 8319.6 8964.6 9149.0 9478.5 8777.1 9022.0 9050.9 9068.0 9080.3 2516.7 2552.1 2555.2 2561.3 2561.7 2434.6 2569.3 2572.0 2577.1 2583.3 2219.7 2541.1 2575.4 2577.0 2592.5 2540.3 2556.5 2572.9 2583.7 2589.9 2539.5 2561.6 2565.3 2567.5 2582.7 8385.8 8749.6 8864.4 9121.4 9148.8 5640.1 5877.9 5883.1 5888.3 5890.7 3638.0 3733.3 3747.1 3747.4 3786.6 1089.5 1089.9 1090.6 1131.4 1131.8 12299.7 12413.9 12513.4 12519.4 12520.7 4827.4 4832.0 4904.9 4932.2 4960.9 9709.5 9716.3 9717.9 9731.6 9733.0 5663.4 5669.9 5677.5 5677.9 5680.8 4104.2 4218.3 4800.6 5242.5 5279.9 3860.7 3897.3 3957.1 3971.3 3981.6 1236.7 1250.5 1255.8 1262.6 1265.7 1423.6 1450.9 1466.6 1474.1 1492.9 8553.6 8597.7 8617.3 8672.6 8683.7 544.4 550.3 556.9 558.4 559.8 6438.9 6448.3 6522.0 6554.6 6561.6 11071.3 11623.5 11639.1 11662.7 11704.3 11148.7 11164.4 11273.2 11284.9 11406.5 8830.9 8835.6 8871.4 8918.9 8921.6 8032.2 8253.7 8348.2 8362.1 8380.4 9754.0 9759.3 9791.0 9846.8 10089.1 7848.5 10385.9 10436.8 10457.5 10469.5 7020.5 7225.5 7486.6 7540.1 7662.0 8419.5 8430.0 8478.6 8480.8 8510.3 7468.5 7568.8 7662.0 7674.5 7706.3 7378.1 7429.1 7447.2 7583.7 7586.4 7759.3 8018.2 8025.3 8034.8 8035.9 7186.2 7196.4 7223.0 7281.7 7298.9 7377.4 7383.4 7427.6 7431.3 7442.6 06:47:54 INFO - PROCESS | 2001 | 06:47:54 INFO - PROCESS | 2001 | [#4] prototype.html Cycles:180 Average:5688.21 Median:6469.74 stddev:1778.65 (27.5%) stddev-sans-first:1737.64 06:47:54 INFO - PROCESS | 2001 | Values: 334.1 344.9 345.7 348.2 352.8 6504.5 6519.5 6536.9 6550.4 6563.2 5233.6 6472.7 6519.4 6520.7 6545.8 4594.3 4683.1 4759.1 4887.0 4898.9 4193.3 4672.7 4815.7 4885.1 4894.5 4151.5 4753.7 4856.3 4869.4 4883.0 4633.3 4637.2 4757.9 4791.4 4798.2 4081.1 4091.5 4093.6 4101.7 4102.3 6083.4 6115.2 6137.1 6179.9 6221.8 5733.1 5737.2 5738.2 5741.5 5741.8 6823.6 6833.5 6847.1 6865.0 6884.0 4511.7 4665.3 4682.3 4713.9 4719.5 6982.9 7226.5 7273.8 7278.5 7279.4 4805.7 4814.2 4814.4 4816.0 4816.9 4863.3 4864.9 4866.0 4866.9 4885.8 5759.2 5761.7 5763.2 5766.8 5779.3 6685.6 6887.8 6924.9 6927.6 6949.5 1538.2 1684.1 1696.7 1701.0 1701.2 1037.9 1071.8 1097.9 1102.4 1130.4 6486.6 6651.8 6672.0 6681.4 6690.2 7221.8 7251.0 7271.6 7291.2 7319.3 6639.7 6650.2 6652.0 6671.4 6685.4 3691.3 3753.0 3798.3 3806.1 3808.1 7445.0 7516.1 7540.8 7542.4 7584.7 6046.4 7346.0 7384.8 7389.3 7389.8 7466.5 7469.9 7479.4 7492.8 7497.3 5241.3 6228.3 7183.7 7187.3 7190.7 6311.3 6699.5 7066.0 7078.0 7085.3 7461.2 7503.2 7526.0 7542.6 7543.0 4841.0 4847.5 4847.9 4848.6 4848.9 7165.1 7170.4 7170.5 7177.6 7180.8 6657.5 6937.4 6938.7 6945.8 6968.2 5922.4 6907.4 6924.2 6931.9 6956.1 6254.3 6763.7 6780.6 6788.8 6794.3 6324.3 6666.6 6948.3 6948.9 6968.7 5818.3 6423.9 6466.7 6769.1 6866.7 06:47:54 INFO - PROCESS | 2001 | 06:47:54 INFO - PROCESS | 2001 | [#5] yui.html Cycles:180 Average:19269.74 Median:583.86 stddev:27688.60 (4742.3%) stddev-sans-first:27731.45 06:47:54 INFO - PROCESS | 2001 | Values: 775.8 777.0 780.0 804.4 805.8 15720.9 15906.4 15911.4 15960.2 15961.4 14857.6 14870.5 14899.2 14921.1 14961.5 806.6 811.8 819.6 971.2 998.6 978.1 981.6 987.1 987.9 988.0 1052.2 1058.2 1060.3 1060.8 1061.4 849.4 864.4 866.5 866.5 1034.5 791.6 792.0 792.6 792.8 794.1 15464.9 15530.5 15538.8 15539.6 15566.6 13540.6 13699.2 13924.0 14049.2 14094.5 10433.6 10439.4 10461.4 10710.8 11000.9 3571.0 3572.0 3659.6 3714.3 3866.8 84656.0 86583.7 87749.6 88165.7 88383.0 9793.9 9844.6 9880.8 10046.9 10661.9 22007.0 22291.1 22330.4 22335.3 22377.7 7675.4 7879.4 8024.0 8105.8 8112.7 4085.2 4209.9 4311.0 4412.6 4579.0 3796.9 3804.5 3809.9 3821.1 3825.2 466.2 594.5 697.8 704.9 706.6 564.9 626.4 645.3 648.0 663.1 7969.4 8522.1 8610.6 8670.8 8904.2 573.2 609.9 623.1 633.3 636.4 3906.7 3936.7 4082.1 4116.9 4248.0 97186.5 97589.0 98733.0 99726.0 101699.0 81155.2 82303.6 83156.6 83283.0 83297.0 75781.6 75986.0 76231.0 76948.0 77195.2 7964.6 8070.5 8199.5 8228.9 8248.1 51250.7 51802.0 51807.4 51891.7 53487.7 66755.0 74205.3 74630.3 75428.6 76083.6 10090.4 10295.4 10332.8 10382.3 10970.7 11120.7 11186.6 11324.2 11431.7 12012.9 10585.4 10624.3 10689.7 10864.6 11424.0 9131.4 10566.4 10816.9 11068.4 11464.4 10600.7 10613.7 10658.9 11000.1 11070.9 8942.3 9164.9 9178.3 9209.0 9326.2 7786.5 9179.4 9190.6 9206.9 9436.3 06:47:54 INFO - PROCESS | 2001 | -------- Summary: end -------- 06:47:54 INFO - PROCESS | 2001 | 06:47:55 INFO - TEST-INFO | 2001: exit 0 06:47:55 INFO - TEST-OK | dromaeo_css | took 1112126ms 06:47:55 INFO - TEST-START | kraken 06:47:55 INFO - operating with platform_type : mac_ 06:47:55 INFO - Initialising browser for kraken test... 06:47:55 INFO - TEST-INFO | started process 2004 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/tmpmRYPhg/profile http://localhost:51340/getInfo.html) 06:47:57 INFO - PROCESS | 2004 | __metrics Screen width/height:1600/1200 06:47:57 INFO - PROCESS | 2004 | colorDepth:24 06:47:57 INFO - PROCESS | 2004 | Browser inner width/height: 1024/689 06:47:57 INFO - PROCESS | 2004 | __metrics 06:47:57 INFO - PROCESS | 2004 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:47:57 INFO - PROCESS | 2004 | JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:47:58 INFO - TEST-INFO | 2004: exit 0 06:47:58 INFO - Browser initialized. 06:47:58 INFO - Running cycle 1/1 for kraken test... 06:47:58 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/tmpmRYPhg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:48:09 INFO - PROCESS | 2007 | RSS: Main: 157241344 06:48:09 INFO - PROCESS | 2007 | 06:48:12 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51340/tests/kraken/driver.html?testName=audio-beat-detection) 06:48:13 INFO - PROCESS | 2007 | RSS: Main: 218836992 06:48:13 INFO - PROCESS | 2007 | 06:48:15 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51340/tests/kraken/driver.html?testName=audio-dft) 06:48:16 INFO - PROCESS | 2007 | RSS: Main: 230715392 06:48:16 INFO - PROCESS | 2007 | 06:48:19 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51340/tests/kraken/driver.html?testName=audio-fft) 06:48:20 INFO - PROCESS | 2007 | RSS: Main: 219377664 06:48:20 INFO - PROCESS | 2007 | 06:48:22 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51340/tests/kraken/driver.html?testName=audio-oscillator) 06:48:22 INFO - PROCESS | 2007 | RSS: Main: 219873280 06:48:22 INFO - PROCESS | 2007 | 06:48:24 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51340/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:48:25 INFO - PROCESS | 2007 | RSS: Main: 220692480 06:48:25 INFO - PROCESS | 2007 | 06:48:27 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51340/tests/kraken/driver.html?testName=imaging-darkroom) 06:48:28 INFO - PROCESS | 2007 | RSS: Main: 220651520 06:48:28 INFO - PROCESS | 2007 | 06:48:31 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51340/tests/kraken/driver.html?testName=imaging-desaturate) 06:48:31 INFO - PROCESS | 2007 | RSS: Main: 220938240 06:48:31 INFO - PROCESS | 2007 | 06:48:34 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51340/tests/kraken/driver.html?testName=json-parse-financial) 06:48:35 INFO - PROCESS | 2007 | RSS: Main: 221061120 06:48:35 INFO - PROCESS | 2007 | 06:48:36 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51340/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:48:37 INFO - PROCESS | 2007 | RSS: Main: 255897600 06:48:37 INFO - PROCESS | 2007 | 06:48:39 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51340/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:48:39 INFO - PROCESS | 2007 | RSS: Main: 256425984 06:48:39 INFO - PROCESS | 2007 | 06:48:41 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51340/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:48:42 INFO - PROCESS | 2007 | RSS: Main: 261820416 06:48:42 INFO - PROCESS | 2007 | 06:48:44 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:48:45 INFO - PROCESS | 2007 | RSS: Main: 263102464 06:48:45 INFO - PROCESS | 2007 | 06:48:47 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:48:48 INFO - PROCESS | 2007 | RSS: Main: 263262208 06:48:48 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | Cycle 1(1): loaded http://localhost:51340/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51340/tests/kraken/driver.html?testName=ai-astar) 06:48:50 INFO - PROCESS | 2007 | RSS: Main: 325984256 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | __start_tp_report 06:48:50 INFO - PROCESS | 2007 | _x_x_mozilla_page_load 06:48:50 INFO - PROCESS | 2007 | _x_x_mozilla_page_load_details 06:48:50 INFO - PROCESS | 2007 | |i|pagename|runs| 06:48:50 INFO - PROCESS | 2007 | |0;ai-astar;112;112;111;112;113;112;130;111;112;109 06:48:50 INFO - PROCESS | 2007 | |1;audio-beat-detection;154;124;144;154;115;139;119;175;172;136 06:48:50 INFO - PROCESS | 2007 | |2;audio-dft;249;254;184;184;182;183;181;178;186;185 06:48:50 INFO - PROCESS | 2007 | |3;audio-fft;74;72;75;117;56;59;58;58;126;56 06:48:50 INFO - PROCESS | 2007 | |4;audio-oscillator;89;93;130;78;79;83;119;76;78;119 06:48:50 INFO - PROCESS | 2007 | |5;imaging-gaussian-blur;89;83;86;84;87;82;87;83;87;82 06:48:50 INFO - PROCESS | 2007 | |6;imaging-darkroom;93;93;93;94;93;92;94;93;93;93 06:48:50 INFO - PROCESS | 2007 | |7;imaging-desaturate;84;83;84;84;85;86;87;86;84;84 06:48:50 INFO - PROCESS | 2007 | |8;json-parse-financial;55;58;57;57;59;58;57;57;68;53 06:48:50 INFO - PROCESS | 2007 | |9;json-stringify-tinderbox;63;61;71;79;70;69;65;66;66;67 06:48:50 INFO - PROCESS | 2007 | |10;stanford-crypto-aes;81;81;82;79;81;97;80;79;80;84 06:48:50 INFO - PROCESS | 2007 | |11;stanford-crypto-ccm;120;118;116;120;128;117;115;117;126;117 06:48:50 INFO - PROCESS | 2007 | |12;stanford-crypto-pbkdf2;135;121;132;131;130;122;155;158;144;128 06:48:50 INFO - PROCESS | 2007 | |13;stanford-crypto-sha256-iterative;65;65;65;68;65;66;66;67;64;60 06:48:50 INFO - PROCESS | 2007 | __end_tp_report 06:48:50 INFO - PROCESS | 2007 | __start_cc_report 06:48:50 INFO - PROCESS | 2007 | _x_x_mozilla_cycle_collect,1208 06:48:50 INFO - PROCESS | 2007 | __end_cc_report 06:48:50 INFO - PROCESS | 2007 | __startTimestamp1465220930407__endTimestamp 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | ------- Summary: start ------- 06:48:50 INFO - PROCESS | 2007 | Number of tests: 14 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#0] ai-astar Cycles:10 Average:113.40 Median:112.00 stddev:5.93 (5.3%) stddev-sans-first:6.27 06:48:50 INFO - PROCESS | 2007 | Values: 112.0 112.0 111.0 112.0 113.0 112.0 130.0 111.0 112.0 109.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#1] audio-beat-detection Cycles:10 Average:143.20 Median:149.00 stddev:20.80 (14.0%) stddev-sans-first:21.69 06:48:50 INFO - PROCESS | 2007 | Values: 154.0 124.0 144.0 154.0 115.0 139.0 119.0 175.0 172.0 136.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#2] audio-dft Cycles:10 Average:196.60 Median:184.50 stddev:29.04 (15.7%) stddev-sans-first:23.83 06:48:50 INFO - PROCESS | 2007 | Values: 249.0 254.0 184.0 184.0 182.0 183.0 181.0 178.0 186.0 185.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#3] audio-fft Cycles:10 Average:75.10 Median:58.50 stddev:25.67 (43.9%) stddev-sans-first:27.22 06:48:50 INFO - PROCESS | 2007 | Values: 74.0 72.0 75.0 117.0 56.0 59.0 58.0 58.0 126.0 56.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#4] audio-oscillator Cycles:10 Average:94.40 Median:78.50 stddev:20.42 (26.0%) stddev-sans-first:21.56 06:48:50 INFO - PROCESS | 2007 | Values: 89.0 93.0 130.0 78.0 79.0 83.0 119.0 76.0 78.0 119.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#5] imaging-gaussian-blur Cycles:10 Average:85.00 Median:86.50 stddev:2.49 (2.9%) stddev-sans-first:2.19 06:48:50 INFO - PROCESS | 2007 | Values: 89.0 83.0 86.0 84.0 87.0 82.0 87.0 83.0 87.0 82.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#6] imaging-darkroom Cycles:10 Average:93.10 Median:93.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 06:48:50 INFO - PROCESS | 2007 | Values: 93.0 93.0 93.0 94.0 93.0 92.0 94.0 93.0 93.0 93.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:84.50 stddev:1.25 (1.5%) stddev-sans-first:1.30 06:48:50 INFO - PROCESS | 2007 | Values: 84.0 83.0 84.0 84.0 85.0 86.0 87.0 86.0 84.0 84.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#8] json-parse-financial Cycles:10 Average:57.90 Median:57.50 stddev:3.93 (6.8%) stddev-sans-first:4.02 06:48:50 INFO - PROCESS | 2007 | Values: 55.0 58.0 57.0 57.0 59.0 58.0 57.0 57.0 68.0 53.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#9] json-stringify-tinderbox Cycles:10 Average:67.70 Median:68.00 stddev:5.01 (7.4%) stddev-sans-first:5.02 06:48:50 INFO - PROCESS | 2007 | Values: 63.0 61.0 71.0 79.0 70.0 69.0 65.0 66.0 66.0 67.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:81.00 stddev:5.34 (6.6%) stddev-sans-first:5.64 06:48:50 INFO - PROCESS | 2007 | Values: 81.0 81.0 82.0 79.0 81.0 97.0 80.0 79.0 80.0 84.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#11] stanford-crypto-ccm Cycles:10 Average:119.40 Median:119.00 stddev:4.33 (3.6%) stddev-sans-first:4.58 06:48:50 INFO - PROCESS | 2007 | Values: 120.0 118.0 116.0 120.0 128.0 117.0 115.0 117.0 126.0 117.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.60 Median:133.50 stddev:12.78 (9.6%) stddev-sans-first:13.56 06:48:50 INFO - PROCESS | 2007 | Values: 135.0 121.0 132.0 131.0 130.0 122.0 155.0 158.0 144.0 128.0 06:48:50 INFO - PROCESS | 2007 | 06:48:50 INFO - PROCESS | 2007 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.50 stddev:2.13 (3.3%) stddev-sans-first:2.26 06:48:50 INFO - PROCESS | 2007 | Values: 65.0 65.0 65.0 68.0 65.0 66.0 66.0 67.0 64.0 60.0 06:48:50 INFO - PROCESS | 2007 | -------- Summary: end -------- 06:48:50 INFO - PROCESS | 2007 | 06:48:51 INFO - TEST-INFO | 2007: exit 0 06:48:51 INFO - TEST-OK | kraken | took 55835ms 06:48:51 INFO - SUITE-END | took 1167s 06:48:51 INFO - Completed test suite (00:19:28) 06:48:51 INFO - javascript benchmark 06:48:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3034.0291106845802, 3624.9093772655697, 3627.7618200431352, 3646.507721457604, 3705.833237504312, 5934.050551911695, 5962.433568810961, 5963.433473819986, 5976.223090998175, 6021.217241758571, 5900.88198236035, 5955.821325360246, 5968.19429377034, 5969.074793407018, 5982.521398288127, 5205.557527610158, 5282.313299271099, 5325.520703136717, 5399.082156033464, 5421.864453388657, 5394.163904594794, 5439.075357189267, 5442.12925931851, 5443.047466693313, 5443.972780136094, 5329.173978033411, 5386.245925570423, 5396.91904621431, 5402.000629883464, 5408.756605952742, 5390.21841832934, 5400.000999815027, 5405.675659460445, 5429.104197807357, 5481.835544933659, 5178.14560597501, 5333.306670132897, 5339.70631615261, 5360.9463905360835, 5393.568514518829, 5750.223719797816, 5750.539956803445, 5768.625039372428, 5795.1017592273265, 5816.970915145397, 6156.076588511714, 6287.1198032275515, 6295.622262664209, 6300.21247344082, 6301.936980630181, 6236.532260080512, 6249.812505624838, 6253.656048917308, 6263.467605253559, 6270.184875966141, 6008.879822403571, 6076.787312444043, 6081.0, 6102.26772787264, 6103.511719062509, 6257.499400047986, 6271.905921411182, 6285.214348206474, 6295.055741638699, 6296.622202667854, 6073.423024812636, 6127.080937859357, 6177.505799536027, 6185.0, 6232.096346029891, 6294.464970477561, 6309.211348581427, 6326.051092336186, 6349.777757778548, 6351.047342898602, 6242.687865606701, 6268.843278917972, 6292.244930608264, 6294.748210071637, 6297.527685423612, 6209.5032397408095, 6210.968945155245, 6301.212348456443, 6308.653024083719, 6315.179026726496, 5017.37282839645, 5034.345535080416, 5047.697138171648, 5049.722265275372, 5049.974750126299, 4536.6824322297125, 4545.3863728396245, 4567.018091110361, 4568.314752787042, 4587.013792034729, 6039.912815693217, 6053.939460605426, 6054.878902422015, 6064.727087281083, 6071.908921366183, 6225.408586184305, 6227.937720622826, 6229.408206220402, 6230.43926046658, 6291.245050593958, 6073.0, 6077.574569780073, 6086.482648974798, 6092.51259899207, 6114.633122012693, 5523.337199536001, 5532.280803495601, 5549.1676248562235, 5550.250716153349, 5550.750216240279, 5554.750036248379, 6289.968550157311, 6422.935770642233, 6531.3142120077655, 6533.705983230861, 6264.467520260647, 6266.279377871603, 6269.49844012487, 6288.465480434214, 6309.085182648582, 6497.480201583957, 6520.380563846427, 6533.41199292066, 6553.705083271169, 6578.342165783383, 6168.414000669929, 6202.472789812917, 6257.499400047895, 6289.0, 6297.811065668037, 6238.937610623836, 6248.281447633581, 6254.906176407267, 6258.780942666985, 6278.46633036197, 6111.926012480351, 6201.162843016135, 6261.624302541862, 6282.654454004891, 6286.4342209201395, 6158.969205153946, 6241.96879015602, 6242.843928901813, 6267.96866015667, 6282.183316168869, 6104.8779024420155, 6130.846728831815, 6132.264128304632, 6161.014237722122, 6169.105479705508, 6118.527810132385, 6189.659568723763, 6286.685665716787, 6292.590981586182, 6309.652969086745, 6030.5778595497895, 6109.1010297800785, 6137.591499645514, 6142.867137759686, 6146.340488068286], "unit": "score", "name": "dojo.html", "value": 5844.120133291336}, {"lowerIsBetter": false, "replicates": [495.5341978540174, 575.9373955052926, 598.7934312360592, 676.28989560961, 681.7886455198887, 40624.39063414047, 41191.79404102979, 41223.38164927521, 41344.58655413445, 41363.75908722743, 44380.556194438046, 45001.324980125326, 45025.7748711256, 45056.0988780225, 45215.0, 9724.416535007904, 9966.402015879034, 9967.252456065788, 9978.101970822625, 9988.152191844532, 9797.363171393872, 9963.053509916546, 9995.100440960312, 10002.199824014098, 10006.449645269508, 9953.800923981516, 10038.749031274203, 10040.347377420481, 10041.849372259421, 10046.095851373375, 9927.503624818766, 10018.549165287579, 10034.197264218845, 10035.448050357227, 10040.945700701432, 9818.90181098187, 9937.453440060794, 9948.10467057961, 9949.850752238723, 9950.900490995069, 43152.0, 43774.78112609449, 43801.0, 43805.780971094944, 43880.78059609682, 3410.2838403934957, 3551.8401671924566, 3555.8933232003083, 3963.989182758407, 4007.579204183577, 28845.85577072122, 29445.263868403246, 29572.964946226777, 30482.0, 31324.21689457759, 2741.7669498092687, 2786.5680819473014, 2820.4077143799623, 2853.1297954123984, 2896.869640866145, 500720.0, 501228.99999999633, 501802.0, 501942.0, 501971.0, 48675.75662121738, 49621.25568116481, 49681.75159124254, 49798.75100624474, 71924.0, 40927.795361023, 48563.75718121387, 48676.0, 48748.0, 48790.512094879305, 16889.408870689465, 17072.743908841378, 17082.743758843626, 17087.487375378758, 17104.0, 13511.729765404636, 13613.251271179983, 13626.727465450835, 13641.590752277447, 13880.722385552433, 13231.66920826987, 15699.607509812346, 15731.528054158394, 15766.842331576538, 15868.841311586737, 6469.838254043687, 6555.672216389162, 6627.4366678831875, 6630.502712296597, 6631.668416579152, 946.6402766948515, 1009.2783659683215, 1056.984145237822, 1060.2684147937898, 1095.1348434736628, 31334.0, 32630.673693263238, 33228.0, 33432.0, 33751.83124084413, 1079.1798233342558, 1079.4926384599225, 1112.4826955465746, 1143.4225716013527, 1159.3449700919123, 11874.406279685982, 13220.537281195113, 14003.0, 16835.242414091394, 16984.74522882158, 680507.0, 703068.0, 703692.0, 703814.0, 705343.0, 64775.02837457442, 65361.346386536476, 65371.67314163399, 65408.0, 65420.01869971954, 1487.9032862863878, 1536.523677659929, 1569.7409927362087, 1601.071378600409, 1605.1091644137616, 29621.555676664437, 30735.538966915963, 31089.756409743357, 31129.066128016195, 31604.0, 50216.497835022645, 50554.988900222525, 50839.49160508347, 51024.489755101975, 51035.74482127566, 360373.396266034, 360458.0, 361084.0, 362491.0, 363408.0, 30545.0, 34818.65181348255, 35350.46974295439, 35604.0, 35674.28651427009, 50297.0, 51016.0, 51289.743551282, 51533.227001595755, 52962.735186325364, 41900.161996759285, 42968.92577685583, 43341.34987975246, 43385.13229735451, 43979.560204398826, 38587.0, 40994.385084224356, 41011.0, 41844.37233441562, 42169.0, 42230.0, 42375.94060148521, 42690.0, 42843.785781070896, 43829.0, 39815.0, 41492.79253603713, 41507.37738933858, 42276.36585451159, 42295.5770442304, 24084.0, 27112.068535639068, 27812.721872781014, 27902.3024424391, 27915.0], "unit": "score", "name": "ext.html", "value": 20436.464126661795}, {"lowerIsBetter": false, "replicates": [334.40642858925406, 394.93483575210075, 395.27072551143146, 396.42716274982655, 400.60140160540266, 16901.7464738029, 16979.74530382045, 20263.0, 22262.332130036106, 22747.317580472612, 18818.435446936615, 21479.55937326016, 21610.0, 22200.77799222011, 22271.331860044185, 5746.597738158331, 5840.415958404157, 5883.146943693162, 5958.046712525997, 5958.97020514899, 4396.120775844828, 5829.970850145764, 5869.647821130725, 6238.500919926395, 6502.804915852532, 6450.096986421905, 6453.225612926455, 6459.6447195404235, 6459.806205813809, 6462.063000864871, 4963.255511673242, 5798.884022319572, 5988.640681559121, 5999.880002399927, 6419.871602567946, 5703.971480142614, 5711.200431939532, 5714.914276285859, 5722.799702010409, 5728.083506638959, 14562.635934101627, 18682.06589670511, 19974.400767976986, 27131.864340678367, 27162.864185678944, 2083.0, 2181.7490988536365, 2187.3219302016428, 2207.7461091974305, 2341.7072865891764, 9884.703458896245, 10663.86722655472, 11298.661040168809, 11385.886141138566, 15499.302531386114, 1740.5126564561942, 1742.2769550636472, 1810.9818901810945, 1830.1398342778873, 1833.1109411935201, 112538.0, 115709.0, 117186.8281317193, 118668.40665796702, 119749.20376194365, 10350.275480716278, 10912.23614347004, 11437.968938231375, 11508.251963622506, 11668.241564298294, 12686.555970540987, 13126.212427254395, 14463.059901106604, 14536.781948270784, 14558.927205363905, 8668.696595619123, 8951.0, 8952.015278319379, 8980.0, 9044.186023257938, 7545.660445279976, 8977.236934860479, 8981.191692747683, 9131.26949844011, 9370.39092458988, 4512.503624601291, 4528.50186479487, 4528.547145285445, 4534.455865296186, 4587.931181032287, 1851.879627824187, 1908.1127275816534, 1910.7802602700867, 1911.5794525204433, 1919.376202734117, 916.3493919317226, 1012.4785735346303, 1038.99480502597, 1086.22877756792, 1087.9129669626411, 20208.0, 20386.0, 20819.37541873746, 21127.0, 21434.678479822815, 860.1957170046027, 905.2667339455063, 1003.2726273451689, 1033.34382667007, 1121.3944469986116, 11299.661010169708, 11369.658910232707, 11387.20289579738, 11398.487068081957, 11477.196596238351, 677747.0, 688061.0, 689251.0, 690888.0, 695972.0, 123296.0, 124740.0, 127535.0, 127888.08167877303, 132571.33714331366, 1099.5326986031064, 1103.8951299626522, 1115.7656892052598, 1144.2791041643877, 1155.0990227622467, 18079.909600451912, 18107.45677629673, 18125.456236312933, 18140.365087221882, 18910.810891890906, 50421.74789126031, 52315.73842130765, 52952.94094118173, 53130.4686953141, 53291.20063199133, 74142.62928685322, 75828.86256706264, 76603.0, 77091.61454192693, 80100.19899800928, 8165.755027349189, 8237.670493180445, 8246.793830154294, 8393.622286996977, 8433.620487078219, 9547.809043819223, 12895.41970611306, 13086.672833179247, 13530.458781648624, 13620.591382258151, 11187.993080622782, 11431.199816013132, 11693.415329233334, 11745.47145378477, 11749.0, 11114.22200445961, 11144.888551114385, 11213.495392707184, 11312.15158863072, 11693.941530292293, 11586.131040171853, 11688.0, 11855.822162667395, 11983.28100313984, 12075.396230188631, 8158.551279679437, 8159.347252219927, 8198.098209196864, 8298.751037468886, 8548.358873084419, 8841.115888411108, 11383.829242561535, 11877.46551405206, 12010.75978480408, 12034.699132521757], "unit": "score", "name": "jquery.html", "value": 9732.258112519232}, {"lowerIsBetter": false, "replicates": [1512.1909778268625, 1512.5159948816383, 1685.5449028762234, 2007.678771396576, 2117.9894100529496, 7941.642626081826, 8319.625616847241, 8964.641414343427, 9148.954255228722, 9478.478683672396, 8777.078406767278, 9022.0, 9050.90949090509, 9068.047854975232, 9080.27357811375, 2516.710578283498, 2552.0940066276485, 2555.1823416506727, 2561.2700380391593, 2561.70540387855, 2434.573949558829, 2569.2549160743456, 2571.9742802572014, 2577.059373328731, 2583.3154214133174, 2219.700340454034, 2541.1106112860443, 2575.446279050004, 2576.987115064422, 2592.468543948486, 2540.276021333911, 2556.4759224359054, 2572.8842202100855, 2583.715791262978, 2589.935251618706, 2539.517491676594, 2561.564534029201, 2565.3073670108965, 2567.4865026994676, 2582.6771653543306, 8385.832283354299, 8749.562521873944, 8864.42381245217, 9121.361504694607, 9148.817023659556, 5640.125780504029, 5877.9412205877825, 5883.0881213411985, 5888.322842873039, 5890.676012819294, 3638.0, 3733.290674771785, 3747.063234191452, 3747.4378843173467, 3786.6402691744242, 1089.4607169451172, 1089.8801131875487, 1090.6291860767299, 1131.3777422417638, 1131.7510147767478, 12299.69250768729, 12413.93793031029, 12513.436895339823, 12519.3740312984, 12520.686982825411, 4827.42070951481, 4832.009438065188, 4904.852854414374, 4932.161532539477, 4960.90078198434, 9709.465979371062, 9716.31985761004, 9717.854232186522, 9731.610735570639, 9732.978037306122, 5663.433656634304, 5669.914951275734, 5677.489025987681, 5677.943220567741, 5680.801171958961, 4104.240715467588, 4218.261804184255, 4800.567948884617, 5242.501962313574, 5279.947200528022, 3860.6718428933855, 3897.279003384383, 3957.149212919179, 3971.2653159165648, 3981.6217459341315, 1236.7341021680381, 1250.5373011985441, 1255.7865162922326, 1262.5707259531803, 1265.73419581887, 1423.5942756314607, 1450.8766754825747, 1466.6480044789387, 1474.115530681604, 1492.8507149284985, 8553.61508732096, 8597.742067737978, 8617.310615150773, 8672.60973256205, 8683.652653893774, 544.4147541393019, 550.3121098626716, 556.9443055694479, 558.3941423555488, 559.7956745787758, 6438.903416448757, 6448.258450278185, 6521.9673901630185, 6554.639494827735, 6561.639109848908, 11071.335719856834, 11623.53505859773, 11639.127065469955, 11662.70843228926, 11704.297742135499, 11148.721281968015, 11164.385958772345, 11273.210875238654, 11284.943575282236, 11406.543738250377, 8830.911690883137, 8835.602397892111, 8871.423357481743, 8918.92972843263, 8921.598528066123, 8032.236937490929, 8253.711120110767, 8348.248657620601, 8362.121977192308, 8380.371472139492, 9754.0, 9759.316847820584, 9790.951045244728, 9846.753831154278, 10089.09198172168, 7848.450608457353, 10385.948070259601, 10436.791264174826, 10457.529411176363, 10469.476526173814, 7020.543664661781, 7225.494215405081, 7486.588237646763, 7540.057492813398, 7661.961690191736, 8419.452735572168, 8430.030546487233, 8478.57607119654, 8480.83038339242, 8510.276626486819, 7468.5145465544565, 7568.772936811904, 7661.961690191736, 7674.501157424749, 7706.306432421109, 7378.114626244885, 7429.14564825052, 7447.218042105501, 7583.696652133853, 7586.355159811478, 7759.340456061298, 8018.198180181935, 8025.2777250047775, 8034.83930321402, 8035.919640803517, 7186.209516953236, 7196.388306993964, 7222.96388518054, 7281.672324745505, 7298.927010729824, 7377.446691498052, 7383.372413344926, 7427.554346739213, 7431.256874312742, 7442.627868606656], "unit": "score", "name": "mootools.html", "value": 5014.543553002105}, {"lowerIsBetter": false, "replicates": [334.0696161191083, 344.91204742790586, 345.6716119686298, 348.1591955427642, 352.8182985762333, 6504.47964162867, 6519.511036672251, 6536.901946470807, 6550.377714117157, 6563.245226798907, 5233.607479439048, 6472.7410903563805, 6519.380658837415, 6520.70656820443, 6545.770898018571, 4594.3338215958665, 4683.133620280242, 4759.071980963713, 4886.951130488703, 4898.877528061791, 4193.266178418779, 4672.696274742148, 4815.735134567597, 4885.145099607572, 4894.53501917319, 4151.481064866892, 4753.691010084351, 4856.3201151838775, 4869.415670119591, 4882.97558512207, 4633.328167415722, 4637.234856248715, 4757.9286310705365, 4791.401074865642, 4798.160321943646, 4081.0817566047403, 4091.5499295077816, 4093.5906409359122, 4101.671866250693, 4102.323116685743, 6083.422074902877, 6115.174451449042, 6137.079438084278, 6179.938200618026, 6221.751129954796, 5733.054046082391, 5737.2254745609225, 5738.225339579145, 5741.483266505993, 5741.799037033726, 6823.55646882951, 6833.487488438337, 6847.144106986627, 6865.0, 6883.965580172117, 4511.70673906195, 4665.300204969248, 4682.274247491644, 4713.882152946169, 4719.457262414832, 6982.930170698279, 7226.494145409823, 7273.818154546126, 7278.490505664606, 7279.417646588313, 4805.663603547788, 4814.15752243356, 4814.350062741555, 4815.975920120377, 4816.8795780105775, 4863.3434486344595, 4864.902701946012, 4865.95134048655, 4866.902661946741, 4885.8045678172475, 5759.1937128802, 5761.711914404347, 5763.242211125647, 5766.826995190151, 5779.33537643168, 6685.6322902240845, 6887.830333445049, 6924.896126558106, 6927.618980956096, 6949.478789090838, 1538.2001359293106, 1684.107423065777, 1696.7200411931892, 1701.0304126647693, 1701.2259421962976, 1037.930931140926, 1071.8338657508098, 1097.8627671541058, 1102.415719668577, 1130.3895896216115, 6486.578372405873, 6651.833704157338, 6671.966640166768, 6681.365270299314, 6690.163729533809, 7221.783346499614, 7250.9637451812405, 7271.63641817907, 7291.161516425573, 7319.304666056716, 6639.701213445406, 6650.235222949326, 6652.0, 6671.366220209073, 6685.39831415175, 3691.2850667165208, 3753.024213704402, 3798.3163030654746, 3806.143617686054, 3808.143167787281, 7445.0, 7516.135644400964, 7540.849183016309, 7542.434317426105, 7584.696612135453, 6046.395360463918, 7346.008288881039, 7384.778456646309, 7389.3349598535315, 7389.81525461857, 7466.514676546007, 7469.879518072224, 7479.401647868158, 7492.7752167435065, 7497.250274972568, 5241.318628578413, 6228.28374736893, 7183.712651494091, 7187.31720486553, 7190.7483238086415, 6311.337309582428, 6699.464042876656, 7066.0, 7078.044463997295, 7085.291470852873, 7461.216572259835, 7503.212162723054, 7525.962370188114, 7542.622868856645, 7543.0, 4840.975795121002, 4847.466778654416, 4847.903041939212, 4848.5636292733825, 4848.903021939612, 7165.104361954755, 7170.42636589082, 7170.462215333767, 7177.605231712306, 7180.820479487846, 6657.53397262187, 6937.375636192565, 6938.687759050956, 6945.756898508528, 6968.163820341591, 5922.378150294157, 6907.378335949788, 6924.169099708067, 6931.949942025492, 6956.095707557985, 6254.343293954252, 6763.729450822108, 6780.627065511444, 6788.811957907247, 6794.252632210551, 6324.272708638381, 6666.566673166229, 6948.33990770876, 6948.895766563607, 6968.686409111703, 5818.272715910512, 6423.871522569429, 6466.741330346734, 6769.120014398293, 6866.6566671667215], "unit": "score", "name": "prototype.html", "value": 5104.108600840372}, {"lowerIsBetter": false, "replicates": [775.768184553262, 777.0481160578296, 780.013283196756, 804.4007214625105, 805.7904944714372, 15720.921395393021, 15906.443274485395, 15911.363545458167, 15960.201989900517, 15961.361545538193, 14857.554273371788, 14870.479533216312, 14899.180545070018, 14921.104733715985, 14961.476348327811, 806.6087947345533, 811.772703642978, 819.5902048975512, 971.1502435369052, 998.6255154317131, 978.0757184460688, 981.6122631560529, 987.0869445762677, 987.920966322696, 987.9823781505062, 1052.2213561964168, 1058.1904842795268, 1060.3213943076437, 1060.8249638809586, 1061.4215252687266, 849.4478588917192, 864.4424346296635, 866.4801119328415, 866.4887716247381, 1034.4517405774952, 791.6160662078887, 792.0495405513407, 792.5918152151589, 792.817651940057, 794.0550744613948, 15464.922675386664, 15530.456434024754, 15538.766918496118, 15539.611509712235, 15566.610834729223, 13540.59378218655, 13699.246541440218, 13924.0, 14049.227292498908, 14094.50669226572, 10433.5826566938, 10439.42583157926, 10461.37231766089, 10710.839337409945, 11000.944995274973, 3570.982145089284, 3572.0304956031273, 3659.6340365963456, 3714.312852122339, 3866.8259928303014, 84656.0, 86583.70124448139, 87749.56125219334, 88165.67751483797, 88383.0, 9793.853092203623, 9844.556994935245, 9880.802383952281, 10046.899531004743, 10661.946690266654, 22007.0, 22291.108355665918, 22330.441738956655, 22335.329940101823, 22377.664335034988, 7675.385969122457, 7879.409044321699, 8024.037115546172, 8105.8378832424205, 8112.716054938049, 4085.22380747657, 4209.852655157055, 4310.956890431118, 4412.580804823537, 4579.015511664941, 3796.905077373088, 3804.505414296124, 3809.8857034289017, 3821.063839359375, 3825.2349530094093, 466.21442868766235, 594.5451729426992, 697.822055375876, 704.9400800931876, 706.6254884911006, 564.9209110724502, 626.37675512865, 645.3353046362255, 647.9902801457982, 663.0882536512296, 7969.402294827795, 8522.062573116953, 8610.569471526398, 8670.78323041929, 8904.181003023601, 573.1717667969743, 609.9451049405575, 623.1276213301414, 633.2812258087105, 636.3572791480638, 3906.746061505993, 3936.7047471439755, 4082.1223436961195, 4116.938245926313, 4248.022954720432, 97186.5140674292, 97589.0, 98733.01266987382, 99726.0, 101699.0, 81155.18844811595, 82303.58848205721, 83156.58421707853, 83283.0, 83297.0, 75781.62109189529, 75986.0, 76231.0, 76948.0, 77195.22804771992, 7964.6415911282975, 8070.515769053875, 8199.549024803455, 8228.917710822816, 8248.070364387013, 51250.718732032, 51801.963960721325, 51807.40962951913, 51891.740541297055, 53487.73256133695, 66755.0, 74205.25794741983, 74630.25369746234, 75428.62285688757, 76083.61958190173, 10090.39457632515, 10295.433751143759, 10332.845007324746, 10382.3251488653, 10970.725731856448, 11120.721981950515, 11186.608468703556, 11324.150688698215, 11431.657050288504, 12012.918837304685, 10585.364878107339, 10624.256302058782, 10689.732756680834, 10864.619738309122, 11423.971842534213, 9131.406458580437, 10566.366018038942, 10816.891831081588, 11068.391238481961, 11464.369459679798, 10600.734981625521, 10613.745311840305, 10658.946705266424, 11000.119990400908, 11070.944645276722, 8942.252715837725, 9164.862527062232, 9178.26573874075, 9208.953955230449, 9326.207272381653, 7786.4938778979185, 9179.357444978787, 9190.632374704937, 9206.907930920874, 9436.339456238273], "unit": "score", "name": "yui.html", "value": 7135.353118627244}], "name": "dromaeo_css", "value": 7723.665258469815}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 112.0, 111.0, 112.0, 113.0, 112.0, 130.0, 111.0, 112.0, 109.0], "unit": "score", "name": "ai-astar", "value": 113.4}, {"lowerIsBetter": true, "replicates": [154.0, 124.0, 144.0, 154.0, 115.0, 139.0, 119.0, 175.0, 172.0, 136.0], "unit": "score", "name": "audio-beat-detection", "value": 143.2}, {"lowerIsBetter": true, "replicates": [249.0, 254.0, 184.0, 184.0, 182.0, 183.0, 181.0, 178.0, 186.0, 185.0], "unit": "score", "name": "audio-dft", "value": 196.6}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 75.0, 117.0, 56.0, 59.0, 58.0, 58.0, 126.0, 56.0], "unit": "score", "name": "audio-fft", "value": 75.1}, {"lowerIsBetter": true, "replicates": [89.0, 93.0, 130.0, 78.0, 79.0, 83.0, 119.0, 76.0, 78.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 94.4}, {"lowerIsBetter": true, "replicates": [89.0, 83.0, 86.0, 84.0, 87.0, 82.0, 87.0, 83.0, 87.0, 82.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 93.0, 94.0, 93.0, 92.0, 94.0, 93.0, 93.0, 93.0], "unit": "score", "name": "imaging-darkroom", "value": 93.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 84.0, 84.0, 85.0, 86.0, 87.0, 86.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 84.7}, {"lowerIsBetter": true, "replicates": [55.0, 58.0, 57.0, 57.0, 59.0, 58.0, 57.0, 57.0, 68.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 57.9}, {"lowerIsBetter": true, "replicates": [63.0, 61.0, 71.0, 79.0, 70.0, 69.0, 65.0, 66.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.7}, {"lowerIsBetter": true, "replicates": [81.0, 81.0, 82.0, 79.0, 81.0, 97.0, 80.0, 79.0, 80.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 116.0, 120.0, 128.0, 117.0, 115.0, 117.0, 126.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 119.4}, {"lowerIsBetter": true, "replicates": [135.0, 121.0, 132.0, 131.0, 130.0, 122.0, 155.0, 158.0, 144.0, 128.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.6}, {"lowerIsBetter": true, "replicates": [65.0, 65.0, 65.0, 68.0, 65.0, 66.0, 66.0, 67.0, 64.0, 60.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 65.1}], "name": "kraken", "value": 1413.6000000000001}]} 06:48:51 INFO - Return code: 0 06:48:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:48:51 INFO - # TBPL SUCCESS # 06:48:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:48:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:48:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:48:51 INFO - 2016-06-06 06:48:51.740 screenresolution[2011:14887] starting screenresolution argv=screenresolution get 06:48:51 INFO - 2016-06-06 06:48:51.743 screenresolution[2011:14887] Display 0: 1600x1200x32@60 06:48:51 INFO - 2016-06-06 06:48:51.749 screenresolution[2012:14890] starting screenresolution argv=screenresolution list 06:48:51 INFO - Available Modes on Display 0 06:48:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:48:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:48:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:48:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:48:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:48:51 INFO - Intel Iris: 06:48:51 INFO - Chipset Model: Intel Iris 06:48:51 INFO - Type: GPU 06:48:51 INFO - Bus: Built-In 06:48:51 INFO - VRAM (Dynamic, Max): 1536 MB 06:48:51 INFO - Vendor: Intel (0x8086) 06:48:51 INFO - Device ID: 0x0a2e 06:48:51 INFO - Revision ID: 0x0009 06:48:51 INFO - Displays: 06:48:51 INFO - Display: 06:48:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:48:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:48:51 INFO - Display Serial Number: 1600x1200 60 06:48:51 INFO - Main Display: Yes 06:48:51 INFO - Mirror: Off 06:48:51 INFO - Online: Yes 06:48:51 INFO - Rotation: Supported 06:48:51 INFO - Return code: 0 06:48:51 INFO - Running post-action listener: _resource_record_post_action 06:48:51 INFO - Running post-run listener: _resource_record_post_run 06:48:53 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 1049088; Write bytes: 506300416; Read time: 9; Write time: 1738 06:48:53 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198459904; Write bytes: 198230528; Read time: 18054; Write time: 437 06:48:53 INFO - run-tests - Wall time: 1170s; CPU: 53.0%; Read bytes: 1049088; Write bytes: 297272832; Read time: 9; Write time: 1267 06:48:53 INFO - Running post-run listener: _upload_blobber_files 06:48:53 INFO - Blob upload gear active. 06:48:53 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:48:53 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:48:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:48:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:48:53 INFO - (blobuploader) - INFO - Open directory for files ... 06:48:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:48:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:48:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:54 INFO - (blobuploader) - INFO - Done attempting. 06:48:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:48:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:48:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:48:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:48:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:48:55 INFO - (blobuploader) - INFO - Done attempting. 06:48:55 INFO - (blobuploader) - INFO - Iteration through files over. 06:48:55 INFO - Return code: 0 06:48:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:48:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:48:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76d2dd73edd5f8ebbcd13eb6edabdf73d99f5290123a7182a192fc9e9a12ea7eaa91953fefd3224272a9360ad88675f6be162549aeff4666ebc17aa6981b6bbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c1ae0bc25b07506e9123949148115376a8b750e6743d453e210536edc9b50d72160b136cf5b1f36c876374702f02e852bc090c6a92165cd149e511c3246e470"} 06:48:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:48:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:48:55 INFO - Contents: 06:48:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76d2dd73edd5f8ebbcd13eb6edabdf73d99f5290123a7182a192fc9e9a12ea7eaa91953fefd3224272a9360ad88675f6be162549aeff4666ebc17aa6981b6bbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c1ae0bc25b07506e9123949148115376a8b750e6743d453e210536edc9b50d72160b136cf5b1f36c876374702f02e852bc090c6a92165cd149e511c3246e470"} 06:48:55 INFO - Running post-run listener: copy_logs_to_upload_dir 06:48:55 INFO - Copying logs to upload dir... 06:48:55 INFO - mkdir: /builds/slave/test/build/upload/logs 06:48:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.992721 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-06-06 06:48:55.238852) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:48:55.242467) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kOffrYcyn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners TMPDIR=/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76d2dd73edd5f8ebbcd13eb6edabdf73d99f5290123a7182a192fc9e9a12ea7eaa91953fefd3224272a9360ad88675f6be162549aeff4666ebc17aa6981b6bbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c1ae0bc25b07506e9123949148115376a8b750e6743d453e210536edc9b50d72160b136cf5b1f36c876374702f02e852bc090c6a92165cd149e511c3246e470"} build_url:https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011053 build_url: 'https://queue.taskcluster.net/v1/task/bfLFZUT5QuCXsq0i4gIfJw/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/76d2dd73edd5f8ebbcd13eb6edabdf73d99f5290123a7182a192fc9e9a12ea7eaa91953fefd3224272a9360ad88675f6be162549aeff4666ebc17aa6981b6bbe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4c1ae0bc25b07506e9123949148115376a8b750e6743d453e210536edc9b50d72160b136cf5b1f36c876374702f02e852bc090c6a92165cd149e511c3246e470"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 06:48:55.274558) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:48:55.274888) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kOffrYcyn6/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.EBNVsamyDb/Listeners TMPDIR=/var/folders/wg/5zm5tl1j1x7gd9_hf2vmp85000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004982 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 06:48:55.324016) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:48:55.324336) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 06:48:55.324672) ========= ========= Total master_lag: 0.17 =========