builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0007 starttime: 1467112141.63 results: success (0) buildid: 20160628020722 builduid: 60530972646444c390f3d916b8144998 revision: 2605c36cc36323c20897fb435e0f742e0c3971d7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:01.628732) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:01.629279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:01.629616) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:01.658517) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:01.658960) ========= 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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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-28 04:09:01-- 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% 163M=0s 2016-06-28 04:09:01 (163 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.181243 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:01.863516) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:01.863879) ========= 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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.028370 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:01.916886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-28 04:09:01.917326) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2605c36cc36323c20897fb435e0f742e0c3971d7 --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 2605c36cc36323c20897fb435e0f742e0c3971d7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.m3ZckvWEDn/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.mBAXwyEx9X/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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-28 04:09:01,992 truncating revision to first 12 chars 2016-06-28 04:09:01,992 Setting DEBUG logging. 2016-06-28 04:09:01,992 attempt 1/10 2016-06-28 04:09:01,992 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2605c36cc363?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-28 04:09:03,243 unpacking tar archive at: mozilla-beta-2605c36cc363/testing/mozharness/ program finished with exit code 0 elapsedTime=1.506577 ========= master_lag: 0.76 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-06-28 04:09:04.182036) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:04.182389) ========= script_repo_revision: 2605c36cc36323c20897fb435e0f742e0c3971d7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:04.182795) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:04.183066) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-28 04:09:04.213859) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-28 04:09:04.214241) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09:04 INFO - MultiFileLogger online at 20160628 04:09:04 in /builds/slave/test 04:09:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:09:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:09:04 INFO - {'append_to_log': False, 04:09:04 INFO - 'base_work_dir': '/builds/slave/test', 04:09:04 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:09:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:09:04 INFO - 'branch': 'Mozilla-Beta', 04:09:04 INFO - 'buildbot_json_path': 'buildprops.json', 04:09:04 INFO - 'config_files': ('talos/mac_config.py',), 04:09:04 INFO - 'default_actions': ('clobber', 04:09:04 INFO - 'read-buildbot-config', 04:09:04 INFO - 'download-and-extract', 04:09:04 INFO - 'populate-webroot', 04:09:04 INFO - 'create-virtualenv', 04:09:04 INFO - 'install', 04:09:04 INFO - 'run-tests'), 04:09:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:09:04 INFO - 'download_minidump_stackwalk': True, 04:09:04 INFO - 'download_symbols': 'ondemand', 04:09:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:09:04 INFO - 'tooltool.py': '/tools/tooltool.py', 04:09:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:09:04 INFO - '/tools/misc-python/virtualenv.py')}, 04:09:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:09:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:09:04 INFO - 'installer_path': 'installer.exe', 04:09:04 INFO - 'log_level': 'info', 04:09:04 INFO - 'log_name': 'talos', 04:09:04 INFO - 'log_to_console': True, 04:09:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:09:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:09:04 INFO - 'opt_config_files': (), 04:09:04 INFO - 'pip_index': False, 04:09:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:09:04 INFO - 'cmd': ('bash', 04:09:04 INFO - '-c', 04:09:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:09:04 INFO - 'enabled': True, 04:09:04 INFO - 'halt_on_failure': False, 04:09:04 INFO - 'name': 'check_screen_resolution'},), 04:09:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:09:04 INFO - 'cmd': ('bash', 04:09:04 INFO - '-c', 04:09:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:09:04 INFO - 'enabled': True, 04:09:04 INFO - 'halt_on_failure': False, 04:09:04 INFO - 'name': 'check_screen_resolution'},), 04:09:04 INFO - 'run_cmd_checks_enabled': True, 04:09:04 INFO - 'sps_profile': False, 04:09:04 INFO - 'sps_profile_interval': 0, 04:09:04 INFO - 'suite': 'dromaeojs-e10s', 04:09:04 INFO - 'system_bits': '32', 04:09:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:09:04 INFO - 'title': 't-yosemite-r7-0007', 04:09:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:09:04 INFO - 'use_talos_json': True, 04:09:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:09:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:09:04 INFO - 'work_dir': 'build'} 04:09:04 INFO - ##### 04:09:04 INFO - ##### Running clobber step. 04:09:04 INFO - ##### 04:09:04 INFO - Running pre-action listener: _resource_record_pre_action 04:09:04 INFO - Running main action method: clobber 04:09:04 INFO - rmtree: /builds/slave/test/build 04:09:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:09:06 INFO - Running post-action listener: _resource_record_post_action 04:09:06 INFO - ##### 04:09:06 INFO - ##### Running read-buildbot-config step. 04:09:06 INFO - ##### 04:09:06 INFO - Running pre-action listener: _resource_record_pre_action 04:09:06 INFO - Running main action method: read_buildbot_config 04:09:06 INFO - Using buildbot properties: 04:09:06 INFO - { 04:09:06 INFO - "project": "", 04:09:06 INFO - "product": "firefox", 04:09:06 INFO - "script_repo_revision": "production", 04:09:06 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:09:06 INFO - "repository": "", 04:09:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:09:06 INFO - "buildid": "20160628020722", 04:09:06 INFO - "pgo_build": "False", 04:09:06 INFO - "basedir": "/builds/slave/test", 04:09:06 INFO - "buildnumber": 42, 04:09:06 INFO - "slavename": "t-yosemite-r7-0007", 04:09:06 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:09:06 INFO - "platform": "yosemite_r7", 04:09:06 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:09:06 INFO - "branch": "mozilla-beta", 04:09:06 INFO - "repo_path": "releases/mozilla-beta", 04:09:06 INFO - "revision": "2605c36cc36323c20897fb435e0f742e0c3971d7", 04:09:06 INFO - "stage_platform": "macosx64", 04:09:06 INFO - "builduid": "60530972646444c390f3d916b8144998", 04:09:06 INFO - "slavebuilddir": "test" 04:09:06 INFO - } 04:09:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:09:06 INFO - Running post-action listener: _resource_record_post_action 04:09:06 INFO - ##### 04:09:06 INFO - ##### Running download-and-extract step. 04:09:06 INFO - ##### 04:09:06 INFO - Running pre-action listener: _resource_record_pre_action 04:09:06 INFO - Running main action method: download_and_extract 04:09:06 INFO - mkdir: /builds/slave/test/build/tests 04:09:06 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')]} 04:09:06 INFO - https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:09:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:09:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:09:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 04:09:07 INFO - Downloaded 1165 bytes. 04:09:07 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:09:07 INFO - Using the following test package requirements: 04:09:07 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:09:07 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:09:07 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:09:07 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:09:07 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:09:07 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:09:07 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:09:07 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:09:07 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:09:07 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:09:07 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:09:07 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:09:07 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:09:07 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:09:07 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:09:07 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:09:07 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:09:07 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:09:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:07 INFO - https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:09:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:09:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:09:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:09:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:09:09 INFO - Downloaded 18350418 bytes. 04:09:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:09:12 INFO - Return code: 0 04:09:12 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:09:12 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')]} 04:09:12 INFO - https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:09:15 INFO - Downloaded 18350418 bytes. 04:09:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:09:18 INFO - Return code: 0 04:09:18 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')]} 04:09:18 INFO - https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:09:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:09:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:09:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 04:09:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 04:09:19 INFO - Downloaded 10840145 bytes. 04:09:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:09:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:09:20 INFO - Return code: 0 04:09:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:20 INFO - https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:09:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:09:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:09:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:09:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 04:09:26 INFO - Downloaded 86199344 bytes. 04:09:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:09:26 INFO - mkdir: /builds/slave/test/properties 04:09:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:09:26 INFO - Writing to file /builds/slave/test/properties/build_url 04:09:26 INFO - Contents: 04:09:26 INFO - build_url:https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:09:28 INFO - Running post-action listener: _resource_record_post_action 04:09:28 INFO - Running post-action listener: set_extra_try_arguments 04:09:28 INFO - ##### 04:09:28 INFO - ##### Running populate-webroot step. 04:09:28 INFO - ##### 04:09:28 INFO - Running pre-action listener: _resource_record_pre_action 04:09:28 INFO - Running main action method: populate_webroot 04:09:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:09:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:09:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:09:28 INFO - '--tppagecycles', 04:09:28 INFO - '7'], 04:09:28 INFO - 'tests': ['tsvgm']}}, 04:09:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:09:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:09:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:09:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:09:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:28 INFO - 'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:09:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:28 INFO - 'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['damp', 'tps']}, 04:09:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:28 INFO - 'tests': ['damp', 'tps']}, 04:09:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['dromaeo_dom']}, 04:09:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:09:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['a11yr', 04:09:28 INFO - 'ts_paint', 04:09:28 INFO - 'tpaint', 04:09:28 INFO - 'sessionrestore', 04:09:28 INFO - 'sessionrestore_no_auto_restore', 04:09:28 INFO - 'tabpaint']}, 04:09:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:09:28 INFO - 'ts_paint', 04:09:28 INFO - 'tpaint', 04:09:28 INFO - 'sessionrestore', 04:09:28 INFO - 'sessionrestore_no_auto_restore', 04:09:28 INFO - 'tabpaint']}, 04:09:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:09:28 INFO - 'ts_paint', 04:09:28 INFO - 'tpaint', 04:09:28 INFO - 'sessionrestore', 04:09:28 INFO - 'sessionrestore_no_auto_restore', 04:09:28 INFO - 'tabpaint']}, 04:09:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:09:28 INFO - 'ts_paint', 04:09:28 INFO - 'tpaint', 04:09:28 INFO - 'sessionrestore', 04:09:28 INFO - 'sessionrestore_no_auto_restore', 04:09:28 INFO - 'tabpaint']}, 04:09:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['a11yr', 04:09:28 INFO - 'ts_paint', 04:09:28 INFO - 'tpaint', 04:09:28 INFO - 'sessionrestore', 04:09:28 INFO - 'sessionrestore_no_auto_restore', 04:09:28 INFO - 'tabpaint']}, 04:09:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['a11yr', 04:09:28 INFO - 'ts_paint', 04:09:28 INFO - 'tpaint', 04:09:28 INFO - 'sessionrestore', 04:09:28 INFO - 'sessionrestore_no_auto_restore', 04:09:28 INFO - 'tabpaint']}, 04:09:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['tsvgx', 04:09:28 INFO - 'tsvgr_opacity', 04:09:28 INFO - 'tart', 04:09:28 INFO - 'tscrollx', 04:09:28 INFO - 'cart']}, 04:09:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:09:28 INFO - 'tsvgr_opacity', 04:09:28 INFO - 'tart', 04:09:28 INFO - 'tscrollx', 04:09:28 INFO - 'cart']}, 04:09:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:28 INFO - 'talos_options': ['--disable-e10s'], 04:09:28 INFO - 'tests': ['tp5o']}, 04:09:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:28 INFO - 'tests': ['tp5o']}, 04:09:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:28 INFO - 'talos_options': ['--disable-e10s', 04:09:28 INFO - '--xperf_path', 04:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:28 INFO - 'tests': ['tp5n']}, 04:09:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:09:28 INFO - 'talos_options': ['--xperf_path', 04:09:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:09:28 INFO - 'tests': ['tp5n']}}, 04:09:28 INFO - 'talos.zip': {'path': '', 04:09:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:09:28 INFO - Running post-action listener: _resource_record_post_action 04:09:28 INFO - ##### 04:09:28 INFO - ##### Running create-virtualenv step. 04:09:28 INFO - ##### 04:09:28 INFO - Running pre-action listener: _resource_record_pre_action 04:09:28 INFO - Running main action method: create_virtualenv 04:09:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:09:28 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 04:09:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:09:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:09:28 INFO - Using real prefix '/tools/python27' 04:09:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:09:28 INFO - Installing distribute.............................................................................................................................................................................................done. 04:09:31 INFO - Installing pip.................done. 04:09:31 INFO - Return code: 0 04:09:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:31 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 0x10d73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a4c0f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, '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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09:31 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 04:09:31 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 04:09:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:09:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:31 INFO - 'HOME': '/Users/cltbld', 04:09:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:31 INFO - 'LOGNAME': 'cltbld', 04:09:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:31 INFO - 'MOZ_NO_REMOTE': '1', 04:09:31 INFO - 'NO_EM_RESTART': '1', 04:09:31 INFO - 'PAGER': '/bin/cat', 04:09:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:31 INFO - 'PWD': '/builds/slave/test', 04:09:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:31 INFO - 'SHELL': '/bin/bash', 04:09:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:09:31 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:09:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:31 INFO - 'USER': 'cltbld', 04:09:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:31 INFO - 'XPC_FLAGS': '0x0', 04:09:31 INFO - 'XPC_SERVICE_NAME': '0', 04:09:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:32 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 04:09:32 INFO - Cleaning up... 04:09:32 INFO - Return code: 0 04:09:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:32 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 0x10d73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a4c0f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, '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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09:32 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 04:09:32 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 04:09:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:09:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:32 INFO - 'HOME': '/Users/cltbld', 04:09:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:32 INFO - 'LOGNAME': 'cltbld', 04:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:32 INFO - 'MOZ_NO_REMOTE': '1', 04:09:32 INFO - 'NO_EM_RESTART': '1', 04:09:32 INFO - 'PAGER': '/bin/cat', 04:09:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:32 INFO - 'PWD': '/builds/slave/test', 04:09:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:32 INFO - 'SHELL': '/bin/bash', 04:09:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:09:32 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:09:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:32 INFO - 'USER': 'cltbld', 04:09:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:32 INFO - 'XPC_FLAGS': '0x0', 04:09:32 INFO - 'XPC_SERVICE_NAME': '0', 04:09:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:32 INFO - Downloading/unpacking psutil>=0.7.1 04:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:09:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:35 INFO - Installing collected packages: psutil 04:09:35 INFO - Running setup.py install for psutil 04:09:35 INFO - building 'psutil._psutil_osx' extension 04:09:35 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 04:09:36 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 04:09:36 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 04:09:36 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 04:09:36 INFO - building 'psutil._psutil_posix' extension 04:09:36 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 04:09:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:09:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:09:36 INFO - ^ 04:09:36 INFO - 1 warning generated. 04:09:36 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 04:09:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:09:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:09:36 INFO - Successfully installed psutil 04:09:36 INFO - Cleaning up... 04:09:36 INFO - Return code: 0 04:09:36 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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', '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 0x10d73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a4c0f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, '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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09: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', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:09: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 mozsystemmonitor==0.0.0 04:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:36 INFO - 'HOME': '/Users/cltbld', 04:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:36 INFO - 'LOGNAME': 'cltbld', 04:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:36 INFO - 'MOZ_NO_REMOTE': '1', 04:09:36 INFO - 'NO_EM_RESTART': '1', 04:09:36 INFO - 'PAGER': '/bin/cat', 04:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:36 INFO - 'PWD': '/builds/slave/test', 04:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:36 INFO - 'SHELL': '/bin/bash', 04:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:09:36 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:36 INFO - 'USER': 'cltbld', 04:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:36 INFO - 'XPC_FLAGS': '0x0', 04:09:36 INFO - 'XPC_SERVICE_NAME': '0', 04:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:36 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:39 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:09:39 INFO - Installing collected packages: mozsystemmonitor 04:09:39 INFO - Running setup.py install for mozsystemmonitor 04:09:39 INFO - Successfully installed mozsystemmonitor 04:09:39 INFO - Cleaning up... 04:09:39 INFO - Return code: 0 04:09:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:09:39 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')]} 04:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:39 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')]} 04:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:39 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 0x10d73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a4c0f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, '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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09:39 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 04:09:39 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 04:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:39 INFO - 'HOME': '/Users/cltbld', 04:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:39 INFO - 'LOGNAME': 'cltbld', 04:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:39 INFO - 'MOZ_NO_REMOTE': '1', 04:09:39 INFO - 'NO_EM_RESTART': '1', 04:09:39 INFO - 'PAGER': '/bin/cat', 04:09:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:39 INFO - 'PWD': '/builds/slave/test', 04:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:39 INFO - 'SHELL': '/bin/bash', 04:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:09:39 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:39 INFO - 'USER': 'cltbld', 04:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:39 INFO - 'XPC_FLAGS': '0x0', 04:09:39 INFO - 'XPC_SERVICE_NAME': '0', 04:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:09:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:09:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:09:43 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 04:09:43 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 04:09:43 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 04:09:43 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 04:09:43 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 04:09:43 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 04:09:43 INFO - Downloading docopt-0.6.1.tar.gz 04:09:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:09:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:09:43 INFO - Running setup.py install for blobuploader 04:09:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:09:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:09:43 INFO - Running setup.py install for requests 04:09:44 INFO - Running setup.py install for docopt 04:09:44 INFO - Successfully installed blobuploader requests docopt 04:09:44 INFO - Cleaning up... 04:09:44 INFO - Return code: 0 04:09:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:44 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')]} 04:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:44 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')]} 04:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:44 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 0x10d73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a4c0f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, '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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09:44 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 04:09:44 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 04:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:44 INFO - 'HOME': '/Users/cltbld', 04:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:44 INFO - 'LOGNAME': 'cltbld', 04:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:44 INFO - 'MOZ_NO_REMOTE': '1', 04:09:44 INFO - 'NO_EM_RESTART': '1', 04:09:44 INFO - 'PAGER': '/bin/cat', 04:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:44 INFO - 'PWD': '/builds/slave/test', 04:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:44 INFO - 'SHELL': '/bin/bash', 04:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:09:44 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:44 INFO - 'USER': 'cltbld', 04:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:44 INFO - 'XPC_FLAGS': '0x0', 04:09:44 INFO - 'XPC_SERVICE_NAME': '0', 04:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:44 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-lJzAng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:44 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-GJk93U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:44 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-uEWOHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-DDB_rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-mcPphe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-4kLGFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-CsLKGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-2Ore77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ZVLpQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-16_KRI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-0ksQvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-mPO_Jh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:45 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-aLcj9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-fKexyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ywLvf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-fVzjoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:46 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-0UEDZR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:09:46 INFO - Running setup.py install for manifestparser 04:09:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:09:46 INFO - Running setup.py install for mozcrash 04:09:46 INFO - Running setup.py install for mozdebug 04:09:46 INFO - Running setup.py install for mozdevice 04:09:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:09:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:09:47 INFO - Running setup.py install for mozfile 04:09:47 INFO - Running setup.py install for mozhttpd 04:09:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:09:47 INFO - Running setup.py install for mozinfo 04:09:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:09:47 INFO - Running setup.py install for mozInstall 04:09:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:09:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:09:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:09:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:09:47 INFO - Running setup.py install for mozleak 04:09:47 INFO - Running setup.py install for mozlog 04:09:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:09:47 INFO - Running setup.py install for moznetwork 04:09:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:09:48 INFO - Running setup.py install for mozprocess 04:09:48 INFO - Running setup.py install for mozprofile 04:09:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:09:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:09:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:09:48 INFO - Running setup.py install for mozrunner 04:09:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:09:48 INFO - Running setup.py install for mozscreenshot 04:09:48 INFO - Running setup.py install for moztest 04:09:48 INFO - Running setup.py install for mozversion 04:09:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:09:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:09:49 INFO - Cleaning up... 04:09:49 INFO - Return code: 0 04:09:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09:49 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')]} 04:09:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:49 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')]} 04:09:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:49 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 0x10d73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a4c0f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, '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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09:49 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 04:09:49 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 04:09:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:09:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:49 INFO - 'HOME': '/Users/cltbld', 04:09:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:49 INFO - 'LOGNAME': 'cltbld', 04:09:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:49 INFO - 'MOZ_NO_REMOTE': '1', 04:09:49 INFO - 'NO_EM_RESTART': '1', 04:09:49 INFO - 'PAGER': '/bin/cat', 04:09:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:49 INFO - 'PWD': '/builds/slave/test', 04:09:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:49 INFO - 'SHELL': '/bin/bash', 04:09:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:09:49 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:09:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:49 INFO - 'USER': 'cltbld', 04:09:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:49 INFO - 'XPC_FLAGS': '0x0', 04:09:49 INFO - 'XPC_SERVICE_NAME': '0', 04:09:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:09:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-4n1JfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:09:49 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)) 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:09:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-1ibfwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:09:49 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)) 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:09:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-EN849Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:09:49 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)) 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:09:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ssRpy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:09:49 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)) 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:09:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-uPl2VS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:09:49 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)) 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:09:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ppkqy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:09:49 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)) 04:09:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:09:49 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-cIZ15b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:09:50 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)) 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:09:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-a5LdrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:09:50 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)) 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:09:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-HKqZ7O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:09:50 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)) 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:09:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-R8imjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:09:50 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)) 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:09:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-KyzDao-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:09:50 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)) 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:09:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-l6Lq63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:09:50 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)) 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:09:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-7WzNxG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:09:50 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)) 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:09:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-_seZ8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:09:50 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)) 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-wV9VZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:09:50 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)) 04:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:09:50 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-YXzugh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:09:51 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)) 04:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:09:51 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Kyq1A6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:09:51 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)) 04:09:51 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)) 04:09:51 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)) 04:09:51 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)) 04:09:51 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)) 04:09:51 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)) 04:09:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:53 INFO - Downloading blessings-1.6.tar.gz 04:09:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:09:53 INFO - Installing collected packages: blessings 04:09:53 INFO - Running setup.py install for blessings 04:09:53 INFO - Successfully installed blessings 04:09:53 INFO - Cleaning up... 04:09:53 INFO - Return code: 0 04:09:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:09:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:09:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:09:54 INFO - Reading from file tmpfile_stdout 04:09:54 INFO - Current package versions: 04:09:54 INFO - blessings == 1.6 04:09:54 INFO - blobuploader == 1.2.4 04:09:54 INFO - docopt == 0.6.1 04:09:54 INFO - manifestparser == 1.1 04:09:54 INFO - mozInstall == 1.12 04:09:54 INFO - mozcrash == 0.17 04:09:54 INFO - mozdebug == 0.1 04:09:54 INFO - mozdevice == 0.48 04:09:54 INFO - mozfile == 1.2 04:09:54 INFO - mozhttpd == 0.7 04:09:54 INFO - mozinfo == 0.9 04:09:54 INFO - mozleak == 0.1 04:09:54 INFO - mozlog == 3.1 04:09:54 INFO - moznetwork == 0.27 04:09:54 INFO - mozprocess == 0.22 04:09:54 INFO - mozprofile == 0.28 04:09:54 INFO - mozrunner == 6.11 04:09:54 INFO - mozscreenshot == 0.1 04:09:54 INFO - mozsystemmonitor == 0.0 04:09:54 INFO - moztest == 0.7 04:09:54 INFO - mozversion == 1.4 04:09:54 INFO - psutil == 3.1.1 04:09:54 INFO - requests == 1.2.3 04:09:54 INFO - wsgiref == 0.1.2 04:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:54 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 0x10d73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a4c0f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, '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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09:54 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 04:09:54 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 04:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:54 INFO - 'HOME': '/Users/cltbld', 04:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:54 INFO - 'LOGNAME': 'cltbld', 04:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:54 INFO - 'MOZ_NO_REMOTE': '1', 04:09:54 INFO - 'NO_EM_RESTART': '1', 04:09:54 INFO - 'PAGER': '/bin/cat', 04:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:54 INFO - 'PWD': '/builds/slave/test', 04:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:54 INFO - 'SHELL': '/bin/bash', 04:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:09:54 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:54 INFO - 'USER': 'cltbld', 04:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:54 INFO - 'XPC_FLAGS': '0x0', 04:09:54 INFO - 'XPC_SERVICE_NAME': '0', 04:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:54 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)) 04:09:54 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)) 04:09:54 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)) 04:09:54 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)) 04:09:54 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)) 04:09:54 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)) 04:09:54 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)) 04:09:54 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)) 04:09:54 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)) 04:09:54 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)) 04:09:54 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)) 04:09:54 INFO - Cleaning up... 04:09:54 INFO - Return code: 0 04:09:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:09: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')]} 04:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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')]} 04:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10d73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a4c0f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, '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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09: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', 'jsonschema'] in /builds/slave/test/build 04:09: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 jsonschema 04:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:54 INFO - 'HOME': '/Users/cltbld', 04:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:54 INFO - 'LOGNAME': 'cltbld', 04:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:54 INFO - 'MOZ_NO_REMOTE': '1', 04:09:54 INFO - 'NO_EM_RESTART': '1', 04:09:54 INFO - 'PAGER': '/bin/cat', 04:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:54 INFO - 'PWD': '/builds/slave/test', 04:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:54 INFO - 'SHELL': '/bin/bash', 04:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:09:54 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:54 INFO - 'USER': 'cltbld', 04:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:54 INFO - 'XPC_FLAGS': '0x0', 04:09:54 INFO - 'XPC_SERVICE_NAME': '0', 04:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:54 INFO - Downloading/unpacking jsonschema 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09: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 04:09:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:09:58 INFO - Downloading/unpacking functools32 (from jsonschema) 04:09:58 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 04:09:58 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 04:09:58 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 04:09:58 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 04:09:58 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 04:09:58 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 04:09:58 INFO - Downloading functools32-3.2.3-2.tar.gz 04:09:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:09:58 INFO - warning: no files found matching '*.txt' 04:09:58 INFO - no previously-included directories found matching 'build' 04:09:58 INFO - no previously-included directories found matching 'dist' 04:09:58 INFO - no previously-included directories found matching '.git*' 04:09:58 INFO - Installing collected packages: jsonschema, functools32 04:09:58 INFO - Running setup.py install for functools32 04:09:58 INFO - warning: no files found matching '*.txt' 04:09:58 INFO - no previously-included directories found matching 'build' 04:09:58 INFO - no previously-included directories found matching 'dist' 04:09:58 INFO - no previously-included directories found matching '.git*' 04:09:58 INFO - Successfully installed jsonschema functools32 04:09:58 INFO - Cleaning up... 04:09:59 INFO - Return code: 0 04:09:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:09:59 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')]} 04:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:59 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')]} 04:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:09:59 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 0x10d73aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d74a420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff90a4c0f40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, '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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 04:09:59 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 04:09:59 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 04:09:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:09:59 INFO - 'HOME': '/Users/cltbld', 04:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:09:59 INFO - 'LOGNAME': 'cltbld', 04:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:59 INFO - 'MOZ_NO_REMOTE': '1', 04:09:59 INFO - 'NO_EM_RESTART': '1', 04:09:59 INFO - 'PAGER': '/bin/cat', 04:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:59 INFO - 'PWD': '/builds/slave/test', 04:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:09:59 INFO - 'SHELL': '/bin/bash', 04:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:09:59 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:09:59 INFO - 'USER': 'cltbld', 04:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:59 INFO - 'XPC_FLAGS': '0x0', 04:09:59 INFO - 'XPC_SERVICE_NAME': '0', 04:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:09:59 INFO - Downloading/unpacking flake8 04:09:59 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 04:09:59 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 04:09:59 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 04:09:59 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 04:09:59 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 04:09:59 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 04:10:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:10:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:10:02 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 04:10:02 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 04:10:02 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 04:10:02 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 04:10:02 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 04:10:02 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 04:10:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:10:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:10:03 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 04:10:03 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 04:10:03 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 04:10:03 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 04:10:03 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 04:10:03 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 04:10:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:10:03 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 04:10:03 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 04:10:03 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 04:10:03 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 04:10:03 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 04:10:03 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 04:10:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:10:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:03 INFO - no previously-included directories found matching 'docs/_build' 04:10:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:10:04 INFO - Running setup.py install for pep8 04:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:10:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:10:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:10:04 INFO - no previously-included directories found matching 'docs/_build' 04:10:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:10:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:10:04 INFO - Cleaning up... 04:10:04 INFO - Return code: 0 04:10:04 INFO - Running post-action listener: _resource_record_post_action 04:10:04 INFO - Running post-action listener: _start_resource_monitoring 04:10:04 INFO - Starting resource monitoring. 04:10:04 INFO - ##### 04:10:04 INFO - ##### Running install step. 04:10:04 INFO - ##### 04:10:04 INFO - Running pre-action listener: _resource_record_pre_action 04:10:04 INFO - Running main action method: install 04:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:10:04 INFO - Reading from file tmpfile_stdout 04:10:04 INFO - Detecting whether we're running mozinstall >=1.0... 04:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:10:04 INFO - Reading from file tmpfile_stdout 04:10:04 INFO - Output received: 04:10:04 INFO - Usage: mozinstall [options] installer 04:10:04 INFO - Options: 04:10:04 INFO - -h, --help show this help message and exit 04:10:04 INFO - -d DEST, --destination=DEST 04:10:04 INFO - Directory to install application into. [default: 04:10:04 INFO - "/builds/slave/test"] 04:10:04 INFO - --app=APP Application being installed. [default: firefox] 04:10:04 INFO - mkdir: /builds/slave/test/build/application 04:10:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:10:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:10:27 INFO - Reading from file tmpfile_stdout 04:10:27 INFO - Output received: 04:10:27 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:10:27 INFO - Running post-action listener: _resource_record_post_action 04:10:27 INFO - ##### 04:10:27 INFO - ##### Running run-tests step. 04:10:27 INFO - ##### 04:10:27 INFO - Running pre-action listener: _resource_record_pre_action 04:10:27 INFO - Running main action method: run_tests 04:10:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:10:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:10:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:10:27 INFO - 2016-06-28 04:10:27.094 screenresolution[1633:7576] starting screenresolution argv=screenresolution get 04:10:27 INFO - 2016-06-28 04:10:27.097 screenresolution[1633:7576] Display 0: 1600x1200x32@60 04:10:27 INFO - 2016-06-28 04:10:27.103 screenresolution[1634:7578] starting screenresolution argv=screenresolution list 04:10:27 INFO - Available Modes on Display 0 04:10:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:10:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:10:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:10:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:10:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:10:27 INFO - Intel Iris: 04:10:27 INFO - Chipset Model: Intel Iris 04:10:27 INFO - Type: GPU 04:10:27 INFO - Bus: Built-In 04:10:27 INFO - VRAM (Dynamic, Max): 1536 MB 04:10:27 INFO - Vendor: Intel (0x8086) 04:10:27 INFO - Device ID: 0x0a2e 04:10:27 INFO - Revision ID: 0x0009 04:10:27 INFO - Displays: 04:10:27 INFO - Display: 04:10:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:10:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:10:27 INFO - Display Serial Number: 1600x1200 60 04:10:27 INFO - Main Display: Yes 04:10:27 INFO - Mirror: Off 04:10:27 INFO - Online: Yes 04:10:27 INFO - Rotation: Supported 04:10:27 INFO - Return code: 0 04:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:10:27 INFO - Python 2.7.3 04:10:27 INFO - Return code: 0 04:10:27 INFO - grabbing minidump binary from tooltool 04:10:27 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')]} 04:10:27 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 0x10d5d9e00>, '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 0x10d442db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5d4b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:10:27 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 04:10:27 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 04:10:27 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:10:27 INFO - Return code: 0 04:10:27 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:10:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:10:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:10:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:10:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:10:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:10:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:10:28 INFO - Return code: 0 04:10:28 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-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:10:28 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-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.m3ZckvWEDn/Render', 04:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:10:28 INFO - 'HOME': '/Users/cltbld', 04:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:10:28 INFO - 'LOGNAME': 'cltbld', 04:10:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:10:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:10:28 INFO - 'MOZ_NO_REMOTE': '1', 04:10:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:10:28 INFO - 'NO_EM_RESTART': '1', 04:10:28 INFO - 'PAGER': '/bin/cat', 04:10:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:10:28 INFO - 'PWD': '/builds/slave/test', 04:10:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:10:28 INFO - 'SHELL': '/bin/bash', 04:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mBAXwyEx9X/Listeners', 04:10:28 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 04:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:10:28 INFO - 'USER': 'cltbld', 04:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:10:28 INFO - 'XPC_FLAGS': '0x0', 04:10:28 INFO - 'XPC_SERVICE_NAME': '0', 04:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:10:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:10:28 INFO - mozversion application_buildid: 20160628020722 04:10:28 INFO - mozversion application_changeset: 2605c36cc36323c20897fb435e0f742e0c3971d7 04:10:28 INFO - mozversion application_display_name: Firefox 04:10:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:10:28 INFO - mozversion application_name: Firefox 04:10:28 INFO - mozversion application_remotingname: firefox 04:10:28 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:10:28 INFO - mozversion application_vendor: Mozilla 04:10:28 INFO - mozversion application_version: 48.0 04:10:28 INFO - mozversion platform_buildid: 20160628020722 04:10:28 INFO - mozversion platform_changeset: 2605c36cc36323c20897fb435e0f742e0c3971d7 04:10:28 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:10:28 INFO - mozversion platform_version: 48.0 04:10:28 INFO - using testdate: 1467112228 04:10:28 INFO - actual date: 1467112228 04:10:28 INFO - starting webserver on 'localhost:49276' 04:10:28 INFO - SUITE-START | Running 2 tests 04:10:28 INFO - TEST-START | dromaeo_css 04:10:28 INFO - operating with platform_type : mac_ 04:10:28 INFO - Initialising browser for dromaeo_css test... 04:10:28 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpZoJVxj/profile http://localhost:49276/getInfo.html) 04:10:31 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 04:10:31 INFO - PROCESS | 1652 | colorDepth:24 04:10:31 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 04:10:31 INFO - PROCESS | 1652 | __metrics 04:10:31 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:10:32 INFO - TEST-INFO | 1652: exit 0 04:10:32 INFO - Browser initialized. 04:10:32 INFO - Running cycle 1/1 for dromaeo_css test... 04:10:32 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpZoJVxj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:44 INFO - PROCESS | 1656 | RSS: Main: 171024384 04:10:44 INFO - PROCESS | 1656 | 04:11:33 INFO - PROCESS | 1656 | 1467112293724 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] 04:13:44 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 04:13:45 INFO - PROCESS | 1656 | RSS: Main: 181964800 04:13:45 INFO - PROCESS | 1656 | 04:16:47 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 04:16:48 INFO - PROCESS | 1656 | RSS: Main: 192606208 04:16:48 INFO - PROCESS | 1656 | 04:19:50 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 04:19:50 INFO - PROCESS | 1656 | RSS: Main: 194736128 04:19:50 INFO - PROCESS | 1656 | 04:22:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 04:22:52 INFO - PROCESS | 1656 | RSS: Main: 198443008 04:22:52 INFO - PROCESS | 1656 | 04:25:55 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 04:25:56 INFO - PROCESS | 1656 | RSS: Main: 197611520 04:25:56 INFO - PROCESS | 1656 | 04:28:58 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 04:28:58 INFO - PROCESS | 1656 | RSS: Main: 203210752 04:28:58 INFO - PROCESS | 1656 | 04:28:58 INFO - PROCESS | 1656 | __start_tp_report 04:28:58 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 04:28:58 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 04:28:58 INFO - PROCESS | 1656 | |i|pagename|runs| 04:28:58 INFO - PROCESS | 1656 | |0;dojo.html;3659.4144936810108;3667.614900435454;3700.8334624941876;3742.0457783265265;3748.906277343066;6035.75856965722;6040.788572399967;6064.423879731429;6081.939180608192;6122.204113465249;6049.576529642915;6054.909176362347;6091.299500557438;6110.725017374218;6121.173641558388;5382.542483888865;5422.024035673578;5479.561635069204;5545.473180047889;5627.071533197018;5393;5475.808346707866;5484.369297530795;5531.834044978657;5572.888542229153;4828.493008234138;5294.761735721882;5499.422560631137;5522.972385138069;5528.336599608053;4756.357891684613;5287.656302340336;5476.835694929158;5502.0921547944545;5573.052581061229;5350.117230656937;5462.6995515246645;5511.118221084647;5519.420460851593;5536.861578460531;5930.614510056876;6043.969780151115;6065.939340606582;6081.847953801146;6097.542684298695;6179.752809887599;6260.624362538262;6299.9370006299805;6308.653024083674;6319.083732858756;6354.110424540568;6365.649889256089;6369;6386.2975072741965;6393.264774550939;6145.600535965148;6171.074338849208;6174.475169610633;6179.81460556184;6184.443400094013;6315.463185629273;6446.258680251831;6469.223693156851;6488.870222595521;6539.08452816606;6260.373962603703;6268.1851359323;6272.3100458949475;6288.52836037299;6288.591241569284;6378.45783108441;6380.904286435707;6384.361563843671;6393.488520918316;6410.391012853772;6178.7219575119225;6232.158658581034;6276.089966954766;6282.026285925689;6298.968505157536;6236.937630623726;6262.09199666055;6292.119103325538;6300.527460440394;6323.715432805535;5018.247262910592;5092.236164575269;5110.514501122388;5116.181410974226;5143.897122057538;4616;4632.72203667781;4659.5573420525;4673.228917228687;4722.905541889143;6189.907151392733;6195.81412557615;6208.099825525273;6248.187735594343;6251.249850017936;5271.947280527223;6265.279492858289;6420.454261387835;6422.165118534561;6445.16212892321;6038.818835434944;6110.315755984981;6148.477379422709;6222.533310001768;6239.251289845248;5566.415526369754;5602.747876345574;5607.551395888319;5634.549236061105;5649.067903795828;6393.584417012972;6445.838854028687;6585.539012269095;6587.604743715392;6588.769393071316;6146.877062458815;6335.873282534416;6407.423331900151;6409.9359006411205;6418.390252925965;6620.040094186413;6628.5028622852515;6645.9003114954285;6655.900161497679;6673.1992160941;5212.530872221519;6240.656763878031;6344.809655710336;6345.746170153327;6347.746090156342;6338.334474880256;6379.234491861006;6401.55189136756;6402.6158430494315;6416.839579010562;5382.488479262673;5610.102383618601;6199.3490683477585;6262.185915830913;6274.435300822948;6184.134221208944;6185.072239164161;6186.505079593531;6214.1921550198185;6257.155284036597;6179.3820617937845;6194.752209911733;6257.311695713559;6282.560220784501;6294.433500984934;6246.531510136849;6248.250209974832;6269.373062693694;6271.96864015677;6281.874362512815;6145.740123274629;6184.072389141665;6221.191245138103;6295.150154729053;6301.117843501822 04:28:58 INFO - PROCESS | 1656 | |1;ext.html;527.4330095147716;547.069981032245;592.484538451547;599.3497055694571;630.7540059376844;39019.80490097549;39990.20019599606;40083.997900052476;40408.39387409191;40414.59585404145;40896.59103408965;41364.37953430701;41439.792801035954;41664.791676041576;41736.791316043375;9725.708228753114;9932;9936.602535898555;9951.601935922554;9972.950135249313;9753.512324383788;9911.355761875455;10011.649592264272;10018.699439016842;10055.64805231817;9981.051800078982;10006.84989725151;10009.24930630202;10089.798204035951;10096.646617368393;9935.602575896955;9949.104580587746;9992.100710935978;10000.94999525005;10038.498075096217;9867.90132098677;9905.00949905011;9969.40183588987;10002.399856008662;10012.749681258027;40042.199156016715;40127;40588.797056014824;40718.77843664695;40927.7953610233;3238.498032804919;3241.1897025743565;3344.8494817733017;3355.6308806031316;3358.9664103358896;27163.592546111824;27214.5917811231;27722.306942326402;28265.717342826516;28586.999455018973;2728.3315587681145;2762.5165596020815;2784.290006048465;2797.2447439191305;2832.994287028096;417139;420805;425324;425588;425619;37216.06959826026;37486.812565937;64287;64621.67689161618;64659.70680586362;36030.27939441196;36251;36253.81873090671;36394.27211455756;36536.81731591325;16265.83734162667;16521.00873947543;16639.25123369451;16777.161141942855;16870.57823554421;14096.154230746188;14221.85778142226;14277;14299.57101286963;14337;8427.073021967579;8477.982642082867;8578.4424012439;8601.31189504838;8647.221750042527;3544.432890737521;3548.538689970339;3579.3736096183065;3588.748787584896;3604.3692353837973;962.5283611030544;1006.2352612014776;1035.435687550272;1039.5685790397051;1044.770150566874;28898.42203155925;29114.41771164565;29158.271043223664;29203.707962920525;29811.40377192444;979.8824141103113;1043.5721354244724;1052.1687866585464;1174.9060075193963;1193.5106606291379;13431.731365372638;15177.013494122846;15473.458428954933;15486.5354039379;15493.829625783814;520135;643402;645655;647251.7637411783;650776;49504;61008.38991610116;61215.38784612097;61848;61862.9999999991;1534.1715473644108;1551.52678433079;1557.0424189123835;1564.5853848730096;1570.6780110077407;29355.41289174247;29419.264518387212;29978.700212998465;30221;30245.243868903453;44829.103417930804;49901.50098499114;51551.48448515617;51795.482045179066;52147;588507;591607;593203;595168;595275;26188.60717089207;26698.19905402841;27212.319692007066;27532.449351013267;27671.169864904085;46894;46900.82747931193;47811;48476.7576162117;48771;38400.03999900025;39100.413493797045;39447.81656550308;39878;40100.1979960405;36466;36508.087297817765;37096.88709338724;37364.252714946095;37879.05302367463;35966.460503092996;36166;36524.63475365212;36664.08339791527;36978;32006.693793797025;33791;33839.492407614394;34063.48904766381;34483;25437.61843572385;25779.484410311314;25783.613245800952;25970.87014564915;26084.34789130287 04:28:58 INFO - PROCESS | 1656 | |2;jquery.html;410.22876991256436;410.49304109424867;410.8993296642323;417.78901654664395;423.63355697321805;20542.38372848817;20869.47826304343;21452.89273553634;21556.81437520938;21565.353039408805;12356.814647780267;12667.93666031671;15764.84235157648;21159.153633854665;22303.776962230415;5444.210589464526;5459.727013649302;5697.6296540724725;5723.2559767230205;5730.68481233532;5591.552675785948;5616.943830561703;5709;5717.171010203518;5732.770689172428;5366.9463305367035;5679.346875109374;5692.8861422771515;5742.511886489653;5748.827535173951;5627.071533197018;5636.802711905064;5663.490285874291;5683.8579035524235;5708.571857110713;5255.474452554752;5460;5546.251256080418;5549.306336707911;5595.804146854841;26363.34091647705;26534.469310613873;26724.19827405181;26916.59625105625;27000.864995675092;1872.5318670332417;2049.2008116834445;2068.379486154148;2117.6717608770664;2162.4810045588947;10147.985201479867;10209.2343074269;10337.844932326021;12461.376931153405;15293.388264469408;1802.630460755542;1813.9274429022823;1843.75109360236;1847.6951303034982;1858.7026075827937;119308.40345798216;122007;122351;123275.76724232733;123654;10814.243002989873;12193.817092743617;12226.388680565937;12272;12310.076744244217;14797.408103675947;15349.539513814603;15489.612759681098;15566.299516521784;15799.763003554956;9396;9451.29115316354;9473.526323683789;9511.952440237754;9526.85709714355;9449.007854175212;9501.714948551555;9503.382280151767;9525.476098814494;9552.14030737237;4873.80504779812;4914.459409464956;4948.134076536592;4959.82640607577;5000.4999500050435;1810.2577943043289;2055.845811564139;2077.8182907946593;2090.811826935583;2106.7471903371693;902.6660135749814;917.1974522292994;922.0126789202934;1007.5466040281902;1113.5323164271026;17266.827331726774;21372.679409808865;21487.140514379564;21556.676649850266;21729.782702173092;1002.2332915319786;1067.64767626683;1098.741795678015;1107.2028139739375;1121.7548521141525;8799.560021998874;11276.811651876278;11360.715982100513;11373.488193031333;11491.253068550517;654399;663479;674870;677370;689525;65909.68180636456;97799;118547;126755.73244267624;138015;1046.8115739167024;1050.4642632257603;1054.367379572266;1075.6665433715416;1086.869575650927;18007.846425683903;18568.628627427104;18789.90605046966;18862.056897155362;19087.42737717871;50667;51467.48532514627;51727.74136129295;52176.21735673892;56628.716856415456;60760.69619651874;77255.2274477248;79438;81857;83022;8114.715984940499;8763.868541971748;8822.161894620001;8848.026717061246;9080.545972701471;11168.720781980515;11361.37512436824;11547.787482314236;12599.93700031494;13039.804402934153;8209.302209312274;11332.490037948477;11544.307341559534;11588.6523404298;11873.346965916957;11422.371769552423;11559.94220028928;11639.709007274547;11978.281303121841;12007.339596321937;9115.954420227856;10481.056704896291;10993.670189894316;11722.765544688888;11981.64055078349;8231.135730748185;8487.915120848713;8623.525706086226;8628.697995570124;8967.641294348414;7031.226565077735;10230;11737.941310293736;11946.641600751991;11988.520459181535 04:28:58 INFO - PROCESS | 1656 | |3;mootools.html;1408.4507042253522;1448.1673038003148;1820.7450956866041;1999.4401567561088;2042.2954080842123;8271.958640206805;8902.554872256378;8961.05908879568;9192.356535042558;9215.447073175606;8946;8972;9032.90967090329;9072.546372681372;9072.63709451621;2539.987300063497;2546.4525127097672;2571.048711976571;2578.187870820695;2578.2909699832603;2511.6483692283095;2553.885075171622;2565.307367010906;2570.8586027768465;2573.9485210295784;2528.671272734542;2536.759007894247;2574.5751950928075;2575.8068144889116;2590.2876708905014;2554.348641096518;2560.5775047117204;2570.5116027954814;2577.4845030993874;2583.651207087038;2285.634298512247;2474.035126300744;2539.2255362114547;2560.9615855762177;2584.056819260975;9186.356955013152;9208.907910920872;9209.309301802325;9246.075392460767;9249.35254532183;5600.803971860965;5636.520895723868;5645.604807663465;5770.6249093808765;5822.679752613604;3619.511365965587;3719.9628003719886;3722.1997270586953;3756.6806821420214;3762.887113386603;1039.5737747523478;1064.8615679961633;1067.2475904487317;1078.14826287233;1078.9244752867303;12083.939580302042;12100.092493062968;12100.515979360904;12105.757884842342;12465;5007.4491805901325;5018.573421259234;5066.594672426197;5087.31321271631;5091.465396133352;10502.949705029589;10540.156787456985;10561.260711750103;10576.418296993585;10594.523246453928;5576.721163941867;5592.636478628876;5603.887922241533;5717.514011309002;5733.426657334233;4631.096936097496;5026.346574945233;5094.465081166424;5132.178851383761;5218.373795144531;4249.617534421917;4255.127698821734;4258.723182993095;4273.444452221192;4283.186194623012;1393.101449565025;1395.7278330725615;1409.6828213652052;1415.2640626873967;1421.2609443089536;867.0938868882033;878.8462019146624;907.5552979040223;910.9180173784258;946.4699768129869;6128.356522565066;6158.168647232566;6201.10084037812;6238.812835614939;6376.904346434807;924.5793164110448;964.9855252171224;980.9313348065567;1029.583018877356;1054.7995880782628;4012.6990475714438;4082.5509193988637;4118.629323360852;4136.276151673445;4143.047099167208;10966.890331096747;11208.943955280172;11410.258333208314;11433.771324573461;11454.255473394203;11015.83476247857;11148.888511114947;11162.107031437628;11164.330140191614;11254.43727813606;8583.656653733906;8632.266257368068;8641.611127499278;8695.043545210021;8763.29893608497;4813.085513752376;5132.435432102391;5347.117725575236;5677.971610141923;5943.078822782476;9766.46284454362;9916.504174791376;10006.599736010477;10130.240231982778;10208.234382421497;10222.335548189641;10441;10473.9476302618;10510.842337364793;10615.83225845172;6639.435647969976;7173.820654483679;7393.630318483947;8220.917790822015;8492.872606910778;8541.359398045048;8560.700375486827;8575.356848236283;8597.656093756179;8606.182412670787;5602.411746766531;7094.9290507094265;7408.111026676834;7466;7742;7467;7505.962470187614;7506.8498630026;7585.16563178061;7598.696052158073;7293.38006269473;7304.7078116876855;7325.523840950535;7346.5592064476305;7364.374028207448;4982.775775090202;5009.5491405773655;5129.897402052013;5156.819511317086;5159.948400515947;5094.617903657315;5115.693058416507;5153.4073581538605;5197.792088316576;5353.759080841293 04:28:58 INFO - PROCESS | 1656 | |4;prototype.html;268.196750731559;332.55271659617813;339.3789365461206;340.370314917403;343.9552858128443;5125.00062487815;6783.050372947791;7049.647517624117;7094.929050709491;7189.71241150354;5736.4550367715;6031.065184896337;6076.817695469132;6922.65386730664;6939.757108501203;3910.648041676249;4508.819647214107;5139.280500729901;5139.972005598876;5162.690238585678;5166.560842328407;5172.6379153459275;5176.767045482943;5176.948230517684;5204.687718736888;5114.258432527281;5117;5124.8975020499565;5162.303089082982;5171.948280517185;4332.631726303268;5002.824336280971;5016.523430274118;5152.793888244466;5163.5352818246165;4416.889577760549;4456.509783923766;4457.955420445786;4477.955220447819;4481.395011673415;6651.401373876326;6710.396064354231;6730.9903514472735;6747.325267473262;6772.18733751948;6042.96978515109;6046.3651316612;6047.304559975615;6056.3338032816355;6067.544934129914;7481.476296659236;7504.362129218968;7515.023047003854;7515.8496830063095;7524.473286869921;4777.163996300634;4952.108620448318;4953.455119936804;4996.1756310208775;5010.949890501085;7815.882761758578;7856.875140551199;7974;7989.081255655616;8031.95984020082;4183.477065366829;4582.175208462509;4755.739728971826;5094.108531007059;5116.488351164854;4590.88522786933;5207.062728708793;5212.921806172911;5220.92168617471;5223.9477605223465;5218.895622087537;6043.305019922677;6043.546733994968;6057.666828324484;6068.33248342682;6353.142325786052;7320.487565870444;7601.809954751176;7633.084029916446;7643;1485.9628509287354;1787.9463616091539;1789.5526118470382;1802.7476153338544;1808.4665023818006;957.7270477913761;1148.8621365436202;1169.9181057326075;1170.4791367841228;1173.3605185174101;7020.157581090302;7140.464465165133;7179.89230161548;7272.63636818157;7318.316787138881;8000.4399692021;8002.679892804339;8012.759617211493;8017.919820801834;8024.79938001543;7227.024351712452;7232.891506627405;7254.673539690727;7261.346478816932;7270.054892864;4110.473878917189;4168.958310416857;4203.495580530356;4233.682473814476;4236.639885609696;8256;8302.169783021649;8339.499630022217;8346.374021948257;8367.163283671583;8215.424920255524;8217.383696222807;8218.301444377175;8225.95887020561;8263.95868020656;7065.399441047466;7869.701499252559;8293.543855088028;8323.375746818892;8337.124147066983;7599.16409194977;7900.446968712135;7942.64258108375;7963.761087167394;7968.6414111363965;7783.066032076187;7797.7270795524155;7797.844043119219;7819.335356494534;7825.295723384695;7421.666025028994;7660.2722741339485;8292.543910085004;8303.4602750821;8312.376571757022;4839.467658557626;4898.436679781871;4913.361263035782;4918.950810491992;4923.483034281349;6940.305969403019;7512.098548174035;7642.426817988562;7837.098733645704;7933.246341597539;6040.637561746309;6152.969235153795;7526.661300241612;7596.658150383136;7640.159582446037;7580.886286705814;7584.469087163846;7584.962075189589;7588.620568971419;7595.658195381332;7160.069191005136;7420.888686669812;7437.702491900263;7448.73929412468;7467.954486372021;7541.660625271767;7612.8477430449975;7629.504082234637;7634.244123851434;7644.350230230492;7086.255943126103;7311.963440182765;7391.889121663287;7406.1482929461645;7448.404127669665 04:28:58 INFO - PROCESS | 1656 | |5;yui.html;717.12152613049;756.3193126186435;761.2767870523;770.7533589251442;772.112071118214;15200.391984320628;15574.377024919004;15579;15614.453494127707;15647.765283520743;14266.857331426709;14372.353244104015;14374.281285935715;14380.352884120213;14388.424463021493;748.8539734751726;902.8058967322024;908.0601577367426;931.8276118918022;932.0958670090001;902.7517432706026;909.122696597783;913.6254135804321;923.7136487688805;929.8140371925608;965.7344230336644;968.0029569543382;971.9416834989888;974.055166488505;976;941.9387739796891;946.7207173883686;956.784723437228;976.1068622210669;977.1352353167463;703.0157779109237;705.9682314295869;713.9357457828769;726.9418446524265;730.240549828178;14790.556283311518;14805.185714785683;14827.962042657018;14971.326290316962;15041.398344066225;11191.776164476747;12971.67570810728;13016.15394999322;13179.934100329438;13181.802272965913;10062.849057264148;10153.187744980383;10183.083522483012;10274.845877311845;10531.578736850593;3560.768550044239;3561.3767590671528;3563.429851223818;3570.589382221026;3669.1194113412857;78798.60600697018;78833;79104.60447697724;80097;80437.79343309914;9640.276979226586;9648.903510964801;9687.70936871895;9738.269629777653;9858;21792.782072179394;22398.104075836785;22417.551648966928;22627.66058509124;22653.546929061657;7665;7720.227977202235;7764.3788496920115;7768.0678318601;7853.607319633996;4149.771762553029;4150.315197992358;4183.49798024239;4287.464066991626;4337.479502459725;3623.239119784822;3635.0003748969243;3695.5750088740137;3706.4625629283605;3752.549694036733;630.4893036640336;641.4804008752925;641.9197600299963;653.434778916234;654.7708302094229;558.2324304081887;597.6682940967804;608.1060840564363;612.0757655939564;617.4967401567708;7378.225286344964;7847.529148251123;8191.262786349257;8372.120927302667;8412;548.347466514854;568.9914651280234;594.2215697436372;608.5405518833253;618.2179542878263;3794.165283637595;3872.3997780344093;3888.6111388861455;3934.2328245991757;4054.493188351456;70557;88020.11979880248;88310.1168988302;88605.55697221601;88782.66825997616;69805.60388792196;70178.9473157903;73869.6306518464;73877;76784;48596;65145.34854651488;67272.66363668151;67898;68474.65762671056;7634.274743899321;7666.846663066819;7703.768886933401;7736.651850666621;7763.961180194063;48069.27896081492;48866.5113348862;49931.75034124806;50115.49884501108;50329;60437;62686.74626507353;68941.65529172322;69114.65442672755;71930.28069719445;10179.847302290324;10200.4389758564;10258.333208341433;10292.433916134685;10434.947825260826;10923.508442119964;11065.059469945145;11107.888921110685;11273.943630281796;11633.6509904703;10282.588696452058;10311.381317120697;10334.276600637882;10383.688489345332;10558;10170.89829101729;10497.737556561147;10786.784264314827;10868.945655271673;11484.885151148716;10529.26295159362;11440.256383335389;11614.767704646029;11778.52885884555;11840.348780817138;9741.756456088655;9745.610175592898;9779.856415145141;9869.506524673881;9920.454375009154;9613.279004074582;9780.16599914112;9966.60133594677;9973.152282056106;9986.450745209084 04:28:58 INFO - PROCESS | 1656 | __end_tp_report 04:28:58 INFO - PROCESS | 1656 | __start_cc_report 04:28:58 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,392 04:28:58 INFO - PROCESS | 1656 | __end_cc_report 04:28:58 INFO - PROCESS | 1656 | __startTimestamp1467113338562__endTimestamp 04:28:58 INFO - PROCESS | 1656 | 04:28:58 INFO - PROCESS | 1656 | ------- Summary: start ------- 04:28:58 INFO - PROCESS | 1656 | Number of tests: 6 04:28:58 INFO - PROCESS | 1656 | 04:28:58 INFO - PROCESS | 1656 | [#0] dojo.html Cycles:165 Average:5947.65 Median:6194.75 stddev:618.17 (10.0%) stddev-sans-first:593.43 04:28:58 INFO - PROCESS | 1656 | Values: 3659.4 3667.6 3700.8 3742.0 3748.9 6035.8 6040.8 6064.4 6081.9 6122.2 6049.6 6054.9 6091.3 6110.7 6121.2 5382.5 5422.0 5479.6 5545.5 5627.1 5393.0 5475.8 5484.4 5531.8 5572.9 4828.5 5294.8 5499.4 5523.0 5528.3 4756.4 5287.7 5476.8 5502.1 5573.1 5350.1 5462.7 5511.1 5519.4 5536.9 5930.6 6044.0 6065.9 6081.8 6097.5 6179.8 6260.6 6299.9 6308.7 6319.1 6354.1 6365.6 6369.0 6386.3 6393.3 6145.6 6171.1 6174.5 6179.8 6184.4 6315.5 6446.3 6469.2 6488.9 6539.1 6260.4 6268.2 6272.3 6288.5 6288.6 6378.5 6380.9 6384.4 6393.5 6410.4 6178.7 6232.2 6276.1 6282.0 6299.0 6236.9 6262.1 6292.1 6300.5 6323.7 5018.2 5092.2 5110.5 5116.2 5143.9 4616.0 4632.7 4659.6 4673.2 4722.9 6189.9 6195.8 6208.1 6248.2 6251.2 5271.9 6265.3 6420.5 6422.2 6445.2 6038.8 6110.3 6148.5 6222.5 6239.3 5566.4 5602.7 5607.6 5634.5 5649.1 6393.6 6445.8 6585.5 6587.6 6588.8 6146.9 6335.9 6407.4 6409.9 6418.4 6620.0 6628.5 6645.9 6655.9 6673.2 5212.5 6240.7 6344.8 6345.7 6347.7 6338.3 6379.2 6401.6 6402.6 6416.8 5382.5 5610.1 6199.3 6262.2 6274.4 6184.1 6185.1 6186.5 6214.2 6257.2 6179.4 6194.8 6257.3 6282.6 6294.4 6246.5 6248.3 6269.4 6272.0 6281.9 6145.7 6184.1 6221.2 6295.2 6301.1 04:28:58 INFO - PROCESS | 1656 | 04:28:58 INFO - PROCESS | 1656 | [#1] ext.html Cycles:180 Average:66951.77 Median:36487.04 stddev:148159.75 (406.1%) stddev-sans-first:148491.44 04:28:58 INFO - PROCESS | 1656 | Values: 527.4 547.1 592.5 599.3 630.8 39019.8 39990.2 40084.0 40408.4 40414.6 40896.6 41364.4 41439.8 41664.8 41736.8 9725.7 9932.0 9936.6 9951.6 9973.0 9753.5 9911.4 10011.6 10018.7 10055.6 9981.1 10006.8 10009.2 10089.8 10096.6 9935.6 9949.1 9992.1 10000.9 10038.5 9867.9 9905.0 9969.4 10002.4 10012.7 40042.2 40127.0 40588.8 40718.8 40927.8 3238.5 3241.2 3344.8 3355.6 3359.0 27163.6 27214.6 27722.3 28265.7 28587.0 2728.3 2762.5 2784.3 2797.2 2833.0 417139.0 420805.0 425324.0 425588.0 425619.0 37216.1 37486.8 64287.0 64621.7 64659.7 36030.3 36251.0 36253.8 36394.3 36536.8 16265.8 16521.0 16639.3 16777.2 16870.6 14096.2 14221.9 14277.0 14299.6 14337.0 8427.1 8478.0 8578.4 8601.3 8647.2 3544.4 3548.5 3579.4 3588.7 3604.4 962.5 1006.2 1035.4 1039.6 1044.8 28898.4 29114.4 29158.3 29203.7 29811.4 979.9 1043.6 1052.2 1174.9 1193.5 13431.7 15177.0 15473.5 15486.5 15493.8 520135.0 643402.0 645655.0 647251.8 650776.0 49504.0 61008.4 61215.4 61848.0 61863.0 1534.2 1551.5 1557.0 1564.6 1570.7 29355.4 29419.3 29978.7 30221.0 30245.2 44829.1 49901.5 51551.5 51795.5 52147.0 588507.0 591607.0 593203.0 595168.0 595275.0 26188.6 26698.2 27212.3 27532.4 27671.2 46894.0 46900.8 47811.0 48476.8 48771.0 38400.0 39100.4 39447.8 39878.0 40100.2 36466.0 36508.1 37096.9 37364.3 37879.1 35966.5 36166.0 36524.6 36664.1 36978.0 32006.7 33791.0 33839.5 34063.5 34483.0 25437.6 25779.5 25783.6 25970.9 26084.3 04:28:58 INFO - PROCESS | 1656 | 04:28:58 INFO - PROCESS | 1656 | [#2] jquery.html Cycles:180 Average:36701.17 Median:21556.75 stddev:111289.73 (516.3%) stddev-sans-first:111568.56 04:28:58 INFO - PROCESS | 1656 | Values: 410.2 410.5 410.9 417.8 423.6 20542.4 20869.5 21452.9 21556.8 21565.4 12356.8 12667.9 15764.8 21159.2 22303.8 5444.2 5459.7 5697.6 5723.3 5730.7 5591.6 5616.9 5709.0 5717.2 5732.8 5366.9 5679.3 5692.9 5742.5 5748.8 5627.1 5636.8 5663.5 5683.9 5708.6 5255.5 5460.0 5546.3 5549.3 5595.8 26363.3 26534.5 26724.2 26916.6 27000.9 1872.5 2049.2 2068.4 2117.7 2162.5 10148.0 10209.2 10337.8 12461.4 15293.4 1802.6 1813.9 1843.8 1847.7 1858.7 119308.4 122007.0 122351.0 123275.8 123654.0 10814.2 12193.8 12226.4 12272.0 12310.1 14797.4 15349.5 15489.6 15566.3 15799.8 9396.0 9451.3 9473.5 9512.0 9526.9 9449.0 9501.7 9503.4 9525.5 9552.1 4873.8 4914.5 4948.1 4959.8 5000.5 1810.3 2055.8 2077.8 2090.8 2106.7 902.7 917.2 922.0 1007.5 1113.5 17266.8 21372.7 21487.1 21556.7 21729.8 1002.2 1067.6 1098.7 1107.2 1121.8 8799.6 11276.8 11360.7 11373.5 11491.3 654399.0 663479.0 674870.0 677370.0 689525.0 65909.7 97799.0 118547.0 126755.7 138015.0 1046.8 1050.5 1054.4 1075.7 1086.9 18007.8 18568.6 18789.9 18862.1 19087.4 50667.0 51467.5 51727.7 52176.2 56628.7 60760.7 77255.2 79438.0 81857.0 83022.0 8114.7 8763.9 8822.2 8848.0 9080.5 11168.7 11361.4 11547.8 12599.9 13039.8 8209.3 11332.5 11544.3 11588.7 11873.3 11422.4 11559.9 11639.7 11978.3 12007.3 9116.0 10481.1 10993.7 11722.8 11981.6 8231.1 8487.9 8623.5 8628.7 8967.6 7031.2 10230.0 11737.9 11946.6 11988.5 04:28:58 INFO - PROCESS | 1656 | 04:28:58 INFO - PROCESS | 1656 | [#3] mootools.html Cycles:180 Average:5937.15 Median:5022.46 stddev:3301.51 (65.7%) stddev-sans-first:3293.23 04:28:58 INFO - PROCESS | 1656 | Values: 1408.5 1448.2 1820.7 1999.4 2042.3 8272.0 8902.6 8961.1 9192.4 9215.4 8946.0 8972.0 9032.9 9072.5 9072.6 2540.0 2546.5 2571.0 2578.2 2578.3 2511.6 2553.9 2565.3 2570.9 2573.9 2528.7 2536.8 2574.6 2575.8 2590.3 2554.3 2560.6 2570.5 2577.5 2583.7 2285.6 2474.0 2539.2 2561.0 2584.1 9186.4 9208.9 9209.3 9246.1 9249.4 5600.8 5636.5 5645.6 5770.6 5822.7 3619.5 3720.0 3722.2 3756.7 3762.9 1039.6 1064.9 1067.2 1078.1 1078.9 12083.9 12100.1 12100.5 12105.8 12465.0 5007.4 5018.6 5066.6 5087.3 5091.5 10502.9 10540.2 10561.3 10576.4 10594.5 5576.7 5592.6 5603.9 5717.5 5733.4 4631.1 5026.3 5094.5 5132.2 5218.4 4249.6 4255.1 4258.7 4273.4 4283.2 1393.1 1395.7 1409.7 1415.3 1421.3 867.1 878.8 907.6 910.9 946.5 6128.4 6158.2 6201.1 6238.8 6376.9 924.6 965.0 980.9 1029.6 1054.8 4012.7 4082.6 4118.6 4136.3 4143.0 10966.9 11208.9 11410.3 11433.8 11454.3 11015.8 11148.9 11162.1 11164.3 11254.4 8583.7 8632.3 8641.6 8695.0 8763.3 4813.1 5132.4 5347.1 5678.0 5943.1 9766.5 9916.5 10006.6 10130.2 10208.2 10222.3 10441.0 10473.9 10510.8 10615.8 6639.4 7173.8 7393.6 8220.9 8492.9 8541.4 8560.7 8575.4 8597.7 8606.2 5602.4 7094.9 7408.1 7466.0 7742.0 7467.0 7506.0 7506.8 7585.2 7598.7 7293.4 7304.7 7325.5 7346.6 7364.4 4982.8 5009.5 5129.9 5156.8 5159.9 5094.6 5115.7 5153.4 5197.8 5353.8 04:28:58 INFO - PROCESS | 1656 | 04:28:58 INFO - PROCESS | 1656 | [#4] prototype.html Cycles:180 Average:6140.73 Median:7034.90 stddev:2004.89 (28.5%) stddev-sans-first:1961.46 04:28:58 INFO - PROCESS | 1656 | Values: 268.2 332.6 339.4 340.4 344.0 5125.0 6783.1 7049.6 7094.9 7189.7 5736.5 6031.1 6076.8 6922.7 6939.8 3910.6 4508.8 5139.3 5140.0 5162.7 5166.6 5172.6 5176.8 5176.9 5204.7 5114.3 5117.0 5124.9 5162.3 5171.9 4332.6 5002.8 5016.5 5152.8 5163.5 4416.9 4456.5 4458.0 4478.0 4481.4 6651.4 6710.4 6731.0 6747.3 6772.2 6043.0 6046.4 6047.3 6056.3 6067.5 7481.5 7504.4 7515.0 7515.8 7524.5 4777.2 4952.1 4953.5 4996.2 5010.9 7815.9 7856.9 7974.0 7989.1 8032.0 4183.5 4582.2 4755.7 5094.1 5116.5 4590.9 5207.1 5212.9 5220.9 5223.9 5218.9 6043.3 6043.5 6057.7 6068.3 6353.1 7320.5 7601.8 7633.1 7643.0 1486.0 1787.9 1789.6 1802.7 1808.5 957.7 1148.9 1169.9 1170.5 1173.4 7020.2 7140.5 7179.9 7272.6 7318.3 8000.4 8002.7 8012.8 8017.9 8024.8 7227.0 7232.9 7254.7 7261.3 7270.1 4110.5 4169.0 4203.5 4233.7 4236.6 8256.0 8302.2 8339.5 8346.4 8367.2 8215.4 8217.4 8218.3 8226.0 8264.0 7065.4 7869.7 8293.5 8323.4 8337.1 7599.2 7900.4 7942.6 7963.8 7968.6 7783.1 7797.7 7797.8 7819.3 7825.3 7421.7 7660.3 8292.5 8303.5 8312.4 4839.5 4898.4 4913.4 4919.0 4923.5 6940.3 7512.1 7642.4 7837.1 7933.2 6040.6 6153.0 7526.7 7596.7 7640.2 7580.9 7584.5 7585.0 7588.6 7595.7 7160.1 7420.9 7437.7 7448.7 7468.0 7541.7 7612.8 7629.5 7634.2 7644.4 7086.3 7312.0 7391.9 7406.1 7448.4 04:28:58 INFO - PROCESS | 1656 | 04:28:58 INFO - PROCESS | 1656 | [#5] yui.html Cycles:180 Average:17673.23 Median:617.86 stddev:24330.49 (3937.9%) stddev-sans-first:24365.43 04:28:58 INFO - PROCESS | 1656 | Values: 717.1 756.3 761.3 770.8 772.1 15200.4 15574.4 15579.0 15614.5 15647.8 14266.9 14372.4 14374.3 14380.4 14388.4 748.9 902.8 908.1 931.8 932.1 902.8 909.1 913.6 923.7 929.8 965.7 968.0 971.9 974.1 976.0 941.9 946.7 956.8 976.1 977.1 703.0 706.0 713.9 726.9 730.2 14790.6 14805.2 14828.0 14971.3 15041.4 11191.8 12971.7 13016.2 13179.9 13181.8 10062.8 10153.2 10183.1 10274.8 10531.6 3560.8 3561.4 3563.4 3570.6 3669.1 78798.6 78833.0 79104.6 80097.0 80437.8 9640.3 9648.9 9687.7 9738.3 9858.0 21792.8 22398.1 22417.6 22627.7 22653.5 7665.0 7720.2 7764.4 7768.1 7853.6 4149.8 4150.3 4183.5 4287.5 4337.5 3623.2 3635.0 3695.6 3706.5 3752.5 630.5 641.5 641.9 653.4 654.8 558.2 597.7 608.1 612.1 617.5 7378.2 7847.5 8191.3 8372.1 8412.0 548.3 569.0 594.2 608.5 618.2 3794.2 3872.4 3888.6 3934.2 4054.5 70557.0 88020.1 88310.1 88605.6 88782.7 69805.6 70178.9 73869.6 73877.0 76784.0 48596.0 65145.3 67272.7 67898.0 68474.7 7634.3 7666.8 7703.8 7736.7 7764.0 48069.3 48866.5 49931.8 50115.5 50329.0 60437.0 62686.7 68941.7 69114.7 71930.3 10179.8 10200.4 10258.3 10292.4 10434.9 10923.5 11065.1 11107.9 11273.9 11633.7 10282.6 10311.4 10334.3 10383.7 10558.0 10170.9 10497.7 10786.8 10868.9 11484.9 10529.3 11440.3 11614.8 11778.5 11840.3 9741.8 9745.6 9779.9 9869.5 9920.5 9613.3 9780.2 9966.6 9973.2 9986.5 04:28:58 INFO - PROCESS | 1656 | -------- Summary: end -------- 04:28:58 INFO - PROCESS | 1656 | 04:28:59 INFO - TEST-INFO | 1656: exit 0 04:28:59 INFO - TEST-OK | dromaeo_css | took 1110346ms 04:28:59 INFO - TEST-START | kraken 04:28:59 INFO - operating with platform_type : mac_ 04:28:59 INFO - Initialising browser for kraken test... 04:28:59 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpl12Ckn/profile http://localhost:49276/getInfo.html) 04:29:01 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 04:29:01 INFO - PROCESS | 1667 | colorDepth:24 04:29:01 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 04:29:01 INFO - PROCESS | 1667 | __metrics 04:29:01 ERROR - PROCESS | 1667 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 04:29:02 INFO - TEST-INFO | 1667: exit 0 04:29:02 INFO - Browser initialized. 04:29:02 INFO - Running cycle 1/1 for kraken test... 04:29:02 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpl12Ckn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:29:14 INFO - PROCESS | 1671 | RSS: Main: 171081728 04:29:14 INFO - PROCESS | 1671 | 04:29:16 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 04:29:17 INFO - PROCESS | 1671 | RSS: Main: 183595008 04:29:17 INFO - PROCESS | 1671 | 04:29:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 04:29:21 INFO - PROCESS | 1671 | RSS: Main: 192233472 04:29:21 INFO - PROCESS | 1671 | 04:29:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 04:29:24 INFO - PROCESS | 1671 | RSS: Main: 196407296 04:29:24 INFO - PROCESS | 1671 | 04:29:26 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 04:29:27 INFO - PROCESS | 1671 | RSS: Main: 196567040 04:29:27 INFO - PROCESS | 1671 | 04:29:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:29:30 INFO - PROCESS | 1671 | RSS: Main: 198082560 04:29:30 INFO - PROCESS | 1671 | 04:29:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 04:29:33 INFO - PROCESS | 1671 | RSS: Main: 197877760 04:29:33 INFO - PROCESS | 1671 | 04:29:36 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 04:29:37 INFO - PROCESS | 1671 | RSS: Main: 197922816 04:29:37 INFO - PROCESS | 1671 | 04:29:40 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 04:29:41 INFO - PROCESS | 1671 | RSS: Main: 198037504 04:29:41 INFO - PROCESS | 1671 | 04:29:42 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:29:43 INFO - PROCESS | 1671 | RSS: Main: 197599232 04:29:43 INFO - PROCESS | 1671 | 04:29:45 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:29:45 INFO - PROCESS | 1671 | RSS: Main: 197652480 04:29:45 INFO - PROCESS | 1671 | 04:29:48 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:29:48 INFO - PROCESS | 1671 | RSS: Main: 197955584 04:29:48 INFO - PROCESS | 1671 | 04:29:51 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:29:52 INFO - PROCESS | 1671 | RSS: Main: 198230016 04:29:52 INFO - PROCESS | 1671 | 04:29:54 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:29:55 INFO - PROCESS | 1671 | RSS: Main: 198012928 04:29:55 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 04:29:57 INFO - PROCESS | 1671 | RSS: Main: 199962624 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | __start_tp_report 04:29:57 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 04:29:57 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 04:29:57 INFO - PROCESS | 1671 | |i|pagename|runs| 04:29:57 INFO - PROCESS | 1671 | |0;ai-astar;115;113;118;117;120;139;163;117;118;114 04:29:57 INFO - PROCESS | 1671 | |1;audio-beat-detection;151;126;167;157;139;168;177;121;165;120 04:29:57 INFO - PROCESS | 1671 | |2;audio-dft;194;198;211;233;192;194;197;197;196;194 04:29:57 INFO - PROCESS | 1671 | |3;audio-fft;67;80;76;169;65;57;58;67;139;82 04:29:57 INFO - PROCESS | 1671 | |4;audio-oscillator;80;81;123;105;94;85;115;81;79;118 04:29:57 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;87;131;133;94;94;89;110;90;89;130 04:29:57 INFO - PROCESS | 1671 | |6;imaging-darkroom;97;98;97;106;151;132;103;145;111;139 04:29:57 INFO - PROCESS | 1671 | |7;imaging-desaturate;145;139;113;96;94;91;91;91;91;92 04:29:57 INFO - PROCESS | 1671 | |8;json-parse-financial;60;62;64;64;65;66;64;78;62;60 04:29:57 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;71;92;99;103;98;74;67;83;60;61 04:29:57 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;83;96;107;84;80;80;94;103;74;104 04:29:57 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;128;127;129;126;124;125;141;150;181;150 04:29:57 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;168;163;167;166;165;160;161;164;163;183 04:29:57 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;72;66;68;66;71;66;67;70;67;65 04:29:57 INFO - PROCESS | 1671 | __end_tp_report 04:29:57 INFO - PROCESS | 1671 | __start_cc_report 04:29:57 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1048 04:29:57 INFO - PROCESS | 1671 | __end_cc_report 04:29:57 INFO - PROCESS | 1671 | __startTimestamp1467113397457__endTimestamp 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | ------- Summary: start ------- 04:29:57 INFO - PROCESS | 1671 | Number of tests: 14 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:123.40 Median:118.00 stddev:15.74 (13.3%) stddev-sans-first:16.40 04:29:57 INFO - PROCESS | 1671 | Values: 115.0 113.0 118.0 117.0 120.0 139.0 163.0 117.0 118.0 114.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:149.10 Median:161.00 stddev:21.21 (13.2%) stddev-sans-first:22.48 04:29:57 INFO - PROCESS | 1671 | Values: 151.0 126.0 167.0 157.0 139.0 168.0 177.0 121.0 165.0 120.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:200.60 Median:197.00 stddev:12.55 (6.4%) stddev-sans-first:13.08 04:29:57 INFO - PROCESS | 1671 | Values: 194.0 198.0 211.0 233.0 192.0 194.0 197.0 197.0 196.0 194.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:86.00 Median:67.00 stddev:37.47 (55.9%) stddev-sans-first:39.11 04:29:57 INFO - PROCESS | 1671 | Values: 67.0 80.0 76.0 169.0 65.0 57.0 58.0 67.0 139.0 82.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:96.10 Median:80.50 stddev:17.56 (21.8%) stddev-sans-first:17.63 04:29:57 INFO - PROCESS | 1671 | Values: 80.0 81.0 123.0 105.0 94.0 85.0 115.0 81.0 79.0 118.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:104.70 Median:89.00 stddev:19.47 (21.9%) stddev-sans-first:19.57 04:29:57 INFO - PROCESS | 1671 | Values: 87.0 131.0 133.0 94.0 94.0 89.0 110.0 90.0 89.0 130.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:117.90 Median:148.00 stddev:21.49 (14.5%) stddev-sans-first:21.42 04:29:57 INFO - PROCESS | 1671 | Values: 97.0 98.0 97.0 106.0 151.0 132.0 103.0 145.0 111.0 139.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:104.30 Median:91.00 stddev:21.00 (23.1%) stddev-sans-first:16.32 04:29:57 INFO - PROCESS | 1671 | Values: 145.0 139.0 113.0 96.0 94.0 91.0 91.0 91.0 91.0 92.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:64.50 Median:64.00 stddev:5.15 (8.0%) stddev-sans-first:5.20 04:29:57 INFO - PROCESS | 1671 | Values: 60.0 62.0 64.0 64.0 65.0 66.0 64.0 78.0 62.0 60.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:80.80 Median:78.50 stddev:16.36 (20.8%) stddev-sans-first:16.96 04:29:57 INFO - PROCESS | 1671 | Values: 71.0 92.0 99.0 103.0 98.0 74.0 67.0 83.0 60.0 61.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:90.50 Median:81.50 stddev:11.76 (14.4%) stddev-sans-first:12.16 04:29:57 INFO - PROCESS | 1671 | Values: 83.0 96.0 107.0 84.0 80.0 80.0 94.0 103.0 74.0 104.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:135.00 stddev:18.13 (13.4%) stddev-sans-first:18.85 04:29:57 INFO - PROCESS | 1671 | Values: 128.0 127.0 129.0 126.0 124.0 125.0 141.0 150.0 181.0 150.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.00 Median:165.50 stddev:6.48 (3.9%) stddev-sans-first:6.83 04:29:57 INFO - PROCESS | 1671 | Values: 168.0 163.0 167.0 166.0 165.0 160.0 161.0 164.0 163.0 183.0 04:29:57 INFO - PROCESS | 1671 | 04:29:57 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:67.50 stddev:2.39 (3.5%) stddev-sans-first:2.00 04:29:57 INFO - PROCESS | 1671 | Values: 72.0 66.0 68.0 66.0 71.0 66.0 67.0 70.0 67.0 65.0 04:29:57 INFO - PROCESS | 1671 | -------- Summary: end -------- 04:29:57 INFO - PROCESS | 1671 | 04:29:58 INFO - TEST-INFO | 1671: exit 0 04:29:58 INFO - TEST-OK | kraken | took 59088ms 04:29:58 INFO - SUITE-END | took 1169s 04:29:58 INFO - Completed test suite (00:19:29) 04:29:58 INFO - javascript benchmark 04:29:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3659.4144936810108, 3667.614900435454, 3700.8334624941876, 3742.0457783265265, 3748.906277343066, 6035.75856965722, 6040.788572399967, 6064.423879731429, 6081.939180608192, 6122.204113465249, 6049.576529642915, 6054.909176362347, 6091.299500557438, 6110.725017374218, 6121.173641558388, 5382.542483888865, 5422.024035673578, 5479.561635069204, 5545.473180047889, 5627.071533197018, 5393.0, 5475.808346707866, 5484.369297530795, 5531.834044978657, 5572.888542229153, 4828.493008234138, 5294.761735721882, 5499.422560631137, 5522.972385138069, 5528.336599608053, 4756.357891684613, 5287.656302340336, 5476.835694929158, 5502.0921547944545, 5573.052581061229, 5350.117230656937, 5462.6995515246645, 5511.118221084647, 5519.420460851593, 5536.861578460531, 5930.614510056876, 6043.969780151115, 6065.939340606582, 6081.847953801146, 6097.542684298695, 6179.752809887599, 6260.624362538262, 6299.9370006299805, 6308.653024083674, 6319.083732858756, 6354.110424540568, 6365.649889256089, 6369.0, 6386.2975072741965, 6393.264774550939, 6145.600535965148, 6171.074338849208, 6174.475169610633, 6179.81460556184, 6184.443400094013, 6315.463185629273, 6446.258680251831, 6469.223693156851, 6488.870222595521, 6539.08452816606, 6260.373962603703, 6268.1851359323, 6272.3100458949475, 6288.52836037299, 6288.591241569284, 6378.45783108441, 6380.904286435707, 6384.361563843671, 6393.488520918316, 6410.391012853772, 6178.7219575119225, 6232.158658581034, 6276.089966954766, 6282.026285925689, 6298.968505157536, 6236.937630623726, 6262.09199666055, 6292.119103325538, 6300.527460440394, 6323.715432805535, 5018.247262910592, 5092.236164575269, 5110.514501122388, 5116.181410974226, 5143.897122057538, 4616.0, 4632.72203667781, 4659.5573420525, 4673.228917228687, 4722.905541889143, 6189.907151392733, 6195.81412557615, 6208.099825525273, 6248.187735594343, 6251.249850017936, 5271.947280527223, 6265.279492858289, 6420.454261387835, 6422.165118534561, 6445.16212892321, 6038.818835434944, 6110.315755984981, 6148.477379422709, 6222.533310001768, 6239.251289845248, 5566.415526369754, 5602.747876345574, 5607.551395888319, 5634.549236061105, 5649.067903795828, 6393.584417012972, 6445.838854028687, 6585.539012269095, 6587.604743715392, 6588.769393071316, 6146.877062458815, 6335.873282534416, 6407.423331900151, 6409.9359006411205, 6418.390252925965, 6620.040094186413, 6628.5028622852515, 6645.9003114954285, 6655.900161497679, 6673.1992160941, 5212.530872221519, 6240.656763878031, 6344.809655710336, 6345.746170153327, 6347.746090156342, 6338.334474880256, 6379.234491861006, 6401.55189136756, 6402.6158430494315, 6416.839579010562, 5382.488479262673, 5610.102383618601, 6199.3490683477585, 6262.185915830913, 6274.435300822948, 6184.134221208944, 6185.072239164161, 6186.505079593531, 6214.1921550198185, 6257.155284036597, 6179.3820617937845, 6194.752209911733, 6257.311695713559, 6282.560220784501, 6294.433500984934, 6246.531510136849, 6248.250209974832, 6269.373062693694, 6271.96864015677, 6281.874362512815, 6145.740123274629, 6184.072389141665, 6221.191245138103, 6295.150154729053, 6301.117843501822], "value": 5912.416373086143, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [527.4330095147716, 547.069981032245, 592.484538451547, 599.3497055694571, 630.7540059376844, 39019.80490097549, 39990.20019599606, 40083.997900052476, 40408.39387409191, 40414.59585404145, 40896.59103408965, 41364.37953430701, 41439.792801035954, 41664.791676041576, 41736.791316043375, 9725.708228753114, 9932.0, 9936.602535898555, 9951.601935922554, 9972.950135249313, 9753.512324383788, 9911.355761875455, 10011.649592264272, 10018.699439016842, 10055.64805231817, 9981.051800078982, 10006.84989725151, 10009.24930630202, 10089.798204035951, 10096.646617368393, 9935.602575896955, 9949.104580587746, 9992.100710935978, 10000.94999525005, 10038.498075096217, 9867.90132098677, 9905.00949905011, 9969.40183588987, 10002.399856008662, 10012.749681258027, 40042.199156016715, 40127.0, 40588.797056014824, 40718.77843664695, 40927.7953610233, 3238.498032804919, 3241.1897025743565, 3344.8494817733017, 3355.6308806031316, 3358.9664103358896, 27163.592546111824, 27214.5917811231, 27722.306942326402, 28265.717342826516, 28586.999455018973, 2728.3315587681145, 2762.5165596020815, 2784.290006048465, 2797.2447439191305, 2832.994287028096, 417139.0, 420805.0, 425324.0, 425588.0, 425619.0, 37216.06959826026, 37486.812565937, 64287.0, 64621.67689161618, 64659.70680586362, 36030.27939441196, 36251.0, 36253.81873090671, 36394.27211455756, 36536.81731591325, 16265.83734162667, 16521.00873947543, 16639.25123369451, 16777.161141942855, 16870.57823554421, 14096.154230746188, 14221.85778142226, 14277.0, 14299.57101286963, 14337.0, 8427.073021967579, 8477.982642082867, 8578.4424012439, 8601.31189504838, 8647.221750042527, 3544.432890737521, 3548.538689970339, 3579.3736096183065, 3588.748787584896, 3604.3692353837973, 962.5283611030544, 1006.2352612014776, 1035.435687550272, 1039.5685790397051, 1044.770150566874, 28898.42203155925, 29114.41771164565, 29158.271043223664, 29203.707962920525, 29811.40377192444, 979.8824141103113, 1043.5721354244724, 1052.1687866585464, 1174.9060075193963, 1193.5106606291379, 13431.731365372638, 15177.013494122846, 15473.458428954933, 15486.5354039379, 15493.829625783814, 520135.0, 643402.0, 645655.0, 647251.7637411783, 650776.0, 49504.0, 61008.38991610116, 61215.38784612097, 61848.0, 61862.9999999991, 1534.1715473644108, 1551.52678433079, 1557.0424189123835, 1564.5853848730096, 1570.6780110077407, 29355.41289174247, 29419.264518387212, 29978.700212998465, 30221.0, 30245.243868903453, 44829.103417930804, 49901.50098499114, 51551.48448515617, 51795.482045179066, 52147.0, 588507.0, 591607.0, 593203.0, 595168.0, 595275.0, 26188.60717089207, 26698.19905402841, 27212.319692007066, 27532.449351013267, 27671.169864904085, 46894.0, 46900.82747931193, 47811.0, 48476.7576162117, 48771.0, 38400.03999900025, 39100.413493797045, 39447.81656550308, 39878.0, 40100.1979960405, 36466.0, 36508.087297817765, 37096.88709338724, 37364.252714946095, 37879.05302367463, 35966.460503092996, 36166.0, 36524.63475365212, 36664.08339791527, 36978.0, 32006.693793797025, 33791.0, 33839.492407614394, 34063.48904766381, 34483.0, 25437.61843572385, 25779.484410311314, 25783.613245800952, 25970.87014564915, 26084.34789130287], "value": 18876.428261885096, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.22876991256436, 410.49304109424867, 410.8993296642323, 417.78901654664395, 423.63355697321805, 20542.38372848817, 20869.47826304343, 21452.89273553634, 21556.81437520938, 21565.353039408805, 12356.814647780267, 12667.93666031671, 15764.84235157648, 21159.153633854665, 22303.776962230415, 5444.210589464526, 5459.727013649302, 5697.6296540724725, 5723.2559767230205, 5730.68481233532, 5591.552675785948, 5616.943830561703, 5709.0, 5717.171010203518, 5732.770689172428, 5366.9463305367035, 5679.346875109374, 5692.8861422771515, 5742.511886489653, 5748.827535173951, 5627.071533197018, 5636.802711905064, 5663.490285874291, 5683.8579035524235, 5708.571857110713, 5255.474452554752, 5460.0, 5546.251256080418, 5549.306336707911, 5595.804146854841, 26363.34091647705, 26534.469310613873, 26724.19827405181, 26916.59625105625, 27000.864995675092, 1872.5318670332417, 2049.2008116834445, 2068.379486154148, 2117.6717608770664, 2162.4810045588947, 10147.985201479867, 10209.2343074269, 10337.844932326021, 12461.376931153405, 15293.388264469408, 1802.630460755542, 1813.9274429022823, 1843.75109360236, 1847.6951303034982, 1858.7026075827937, 119308.40345798216, 122007.0, 122351.0, 123275.76724232733, 123654.0, 10814.243002989873, 12193.817092743617, 12226.388680565937, 12272.0, 12310.076744244217, 14797.408103675947, 15349.539513814603, 15489.612759681098, 15566.299516521784, 15799.763003554956, 9396.0, 9451.29115316354, 9473.526323683789, 9511.952440237754, 9526.85709714355, 9449.007854175212, 9501.714948551555, 9503.382280151767, 9525.476098814494, 9552.14030737237, 4873.80504779812, 4914.459409464956, 4948.134076536592, 4959.82640607577, 5000.4999500050435, 1810.2577943043289, 2055.845811564139, 2077.8182907946593, 2090.811826935583, 2106.7471903371693, 902.6660135749814, 917.1974522292994, 922.0126789202934, 1007.5466040281902, 1113.5323164271026, 17266.827331726774, 21372.679409808865, 21487.140514379564, 21556.676649850266, 21729.782702173092, 1002.2332915319786, 1067.64767626683, 1098.741795678015, 1107.2028139739375, 1121.7548521141525, 8799.560021998874, 11276.811651876278, 11360.715982100513, 11373.488193031333, 11491.253068550517, 654399.0, 663479.0, 674870.0, 677370.0, 689525.0, 65909.68180636456, 97799.0, 118547.0, 126755.73244267624, 138015.0, 1046.8115739167024, 1050.4642632257603, 1054.367379572266, 1075.6665433715416, 1086.869575650927, 18007.846425683903, 18568.628627427104, 18789.90605046966, 18862.056897155362, 19087.42737717871, 50667.0, 51467.48532514627, 51727.74136129295, 52176.21735673892, 56628.716856415456, 60760.69619651874, 77255.2274477248, 79438.0, 81857.0, 83022.0, 8114.715984940499, 8763.868541971748, 8822.161894620001, 8848.026717061246, 9080.545972701471, 11168.720781980515, 11361.37512436824, 11547.787482314236, 12599.93700031494, 13039.804402934153, 8209.302209312274, 11332.490037948477, 11544.307341559534, 11588.6523404298, 11873.346965916957, 11422.371769552423, 11559.94220028928, 11639.709007274547, 11978.281303121841, 12007.339596321937, 9115.954420227856, 10481.056704896291, 10993.670189894316, 11722.765544688888, 11981.64055078349, 8231.135730748185, 8487.915120848713, 8623.525706086226, 8628.697995570124, 8967.641294348414, 7031.226565077735, 10230.0, 11737.941310293736, 11946.641600751991, 11988.520459181535], "value": 9720.576646695905, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1408.4507042253522, 1448.1673038003148, 1820.7450956866041, 1999.4401567561088, 2042.2954080842123, 8271.958640206805, 8902.554872256378, 8961.05908879568, 9192.356535042558, 9215.447073175606, 8946.0, 8972.0, 9032.90967090329, 9072.546372681372, 9072.63709451621, 2539.987300063497, 2546.4525127097672, 2571.048711976571, 2578.187870820695, 2578.2909699832603, 2511.6483692283095, 2553.885075171622, 2565.307367010906, 2570.8586027768465, 2573.9485210295784, 2528.671272734542, 2536.759007894247, 2574.5751950928075, 2575.8068144889116, 2590.2876708905014, 2554.348641096518, 2560.5775047117204, 2570.5116027954814, 2577.4845030993874, 2583.651207087038, 2285.634298512247, 2474.035126300744, 2539.2255362114547, 2560.9615855762177, 2584.056819260975, 9186.356955013152, 9208.907910920872, 9209.309301802325, 9246.075392460767, 9249.35254532183, 5600.803971860965, 5636.520895723868, 5645.604807663465, 5770.6249093808765, 5822.679752613604, 3619.511365965587, 3719.9628003719886, 3722.1997270586953, 3756.6806821420214, 3762.887113386603, 1039.5737747523478, 1064.8615679961633, 1067.2475904487317, 1078.14826287233, 1078.9244752867303, 12083.939580302042, 12100.092493062968, 12100.515979360904, 12105.757884842342, 12465.0, 5007.4491805901325, 5018.573421259234, 5066.594672426197, 5087.31321271631, 5091.465396133352, 10502.949705029589, 10540.156787456985, 10561.260711750103, 10576.418296993585, 10594.523246453928, 5576.721163941867, 5592.636478628876, 5603.887922241533, 5717.514011309002, 5733.426657334233, 4631.096936097496, 5026.346574945233, 5094.465081166424, 5132.178851383761, 5218.373795144531, 4249.617534421917, 4255.127698821734, 4258.723182993095, 4273.444452221192, 4283.186194623012, 1393.101449565025, 1395.7278330725615, 1409.6828213652052, 1415.2640626873967, 1421.2609443089536, 867.0938868882033, 878.8462019146624, 907.5552979040223, 910.9180173784258, 946.4699768129869, 6128.356522565066, 6158.168647232566, 6201.10084037812, 6238.812835614939, 6376.904346434807, 924.5793164110448, 964.9855252171224, 980.9313348065567, 1029.583018877356, 1054.7995880782628, 4012.6990475714438, 4082.5509193988637, 4118.629323360852, 4136.276151673445, 4143.047099167208, 10966.890331096747, 11208.943955280172, 11410.258333208314, 11433.771324573461, 11454.255473394203, 11015.83476247857, 11148.888511114947, 11162.107031437628, 11164.330140191614, 11254.43727813606, 8583.656653733906, 8632.266257368068, 8641.611127499278, 8695.043545210021, 8763.29893608497, 4813.085513752376, 5132.435432102391, 5347.117725575236, 5677.971610141923, 5943.078822782476, 9766.46284454362, 9916.504174791376, 10006.599736010477, 10130.240231982778, 10208.234382421497, 10222.335548189641, 10441.0, 10473.9476302618, 10510.842337364793, 10615.83225845172, 6639.435647969976, 7173.820654483679, 7393.630318483947, 8220.917790822015, 8492.872606910778, 8541.359398045048, 8560.700375486827, 8575.356848236283, 8597.656093756179, 8606.182412670787, 5602.411746766531, 7094.9290507094265, 7408.111026676834, 7466.0, 7742.0, 7467.0, 7505.962470187614, 7506.8498630026, 7585.16563178061, 7598.696052158073, 7293.38006269473, 7304.7078116876855, 7325.523840950535, 7346.5592064476305, 7364.374028207448, 4982.775775090202, 5009.5491405773655, 5129.897402052013, 5156.819511317086, 5159.948400515947, 5094.617903657315, 5115.693058416507, 5153.4073581538605, 5197.792088316576, 5353.759080841293], "value": 4795.574623938542, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [268.196750731559, 332.55271659617813, 339.3789365461206, 340.370314917403, 343.9552858128443, 5125.00062487815, 6783.050372947791, 7049.647517624117, 7094.929050709491, 7189.71241150354, 5736.4550367715, 6031.065184896337, 6076.817695469132, 6922.65386730664, 6939.757108501203, 3910.648041676249, 4508.819647214107, 5139.280500729901, 5139.972005598876, 5162.690238585678, 5166.560842328407, 5172.6379153459275, 5176.767045482943, 5176.948230517684, 5204.687718736888, 5114.258432527281, 5117.0, 5124.8975020499565, 5162.303089082982, 5171.948280517185, 4332.631726303268, 5002.824336280971, 5016.523430274118, 5152.793888244466, 5163.5352818246165, 4416.889577760549, 4456.509783923766, 4457.955420445786, 4477.955220447819, 4481.395011673415, 6651.401373876326, 6710.396064354231, 6730.9903514472735, 6747.325267473262, 6772.18733751948, 6042.96978515109, 6046.3651316612, 6047.304559975615, 6056.3338032816355, 6067.544934129914, 7481.476296659236, 7504.362129218968, 7515.023047003854, 7515.8496830063095, 7524.473286869921, 4777.163996300634, 4952.108620448318, 4953.455119936804, 4996.1756310208775, 5010.949890501085, 7815.882761758578, 7856.875140551199, 7974.0, 7989.081255655616, 8031.95984020082, 4183.477065366829, 4582.175208462509, 4755.739728971826, 5094.108531007059, 5116.488351164854, 4590.88522786933, 5207.062728708793, 5212.921806172911, 5220.92168617471, 5223.9477605223465, 5218.895622087537, 6043.305019922677, 6043.546733994968, 6057.666828324484, 6068.33248342682, 6353.142325786052, 7320.487565870444, 7601.809954751176, 7633.084029916446, 7643.0, 1485.9628509287354, 1787.9463616091539, 1789.5526118470382, 1802.7476153338544, 1808.4665023818006, 957.7270477913761, 1148.8621365436202, 1169.9181057326075, 1170.4791367841228, 1173.3605185174101, 7020.157581090302, 7140.464465165133, 7179.89230161548, 7272.63636818157, 7318.316787138881, 8000.4399692021, 8002.679892804339, 8012.759617211493, 8017.919820801834, 8024.79938001543, 7227.024351712452, 7232.891506627405, 7254.673539690727, 7261.346478816932, 7270.054892864, 4110.473878917189, 4168.958310416857, 4203.495580530356, 4233.682473814476, 4236.639885609696, 8256.0, 8302.169783021649, 8339.499630022217, 8346.374021948257, 8367.163283671583, 8215.424920255524, 8217.383696222807, 8218.301444377175, 8225.95887020561, 8263.95868020656, 7065.399441047466, 7869.701499252559, 8293.543855088028, 8323.375746818892, 8337.124147066983, 7599.16409194977, 7900.446968712135, 7942.64258108375, 7963.761087167394, 7968.6414111363965, 7783.066032076187, 7797.7270795524155, 7797.844043119219, 7819.335356494534, 7825.295723384695, 7421.666025028994, 7660.2722741339485, 8292.543910085004, 8303.4602750821, 8312.376571757022, 4839.467658557626, 4898.436679781871, 4913.361263035782, 4918.950810491992, 4923.483034281349, 6940.305969403019, 7512.098548174035, 7642.426817988562, 7837.098733645704, 7933.246341597539, 6040.637561746309, 6152.969235153795, 7526.661300241612, 7596.658150383136, 7640.159582446037, 7580.886286705814, 7584.469087163846, 7584.962075189589, 7588.620568971419, 7595.658195381332, 7160.069191005136, 7420.888686669812, 7437.702491900263, 7448.73929412468, 7467.954486372021, 7541.660625271767, 7612.8477430449975, 7629.504082234637, 7634.244123851434, 7644.350230230492, 7086.255943126103, 7311.963440182765, 7391.889121663287, 7406.1482929461645, 7448.404127669665], "value": 5463.875924786211, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [717.12152613049, 756.3193126186435, 761.2767870523, 770.7533589251442, 772.112071118214, 15200.391984320628, 15574.377024919004, 15579.0, 15614.453494127707, 15647.765283520743, 14266.857331426709, 14372.353244104015, 14374.281285935715, 14380.352884120213, 14388.424463021493, 748.8539734751726, 902.8058967322024, 908.0601577367426, 931.8276118918022, 932.0958670090001, 902.7517432706026, 909.122696597783, 913.6254135804321, 923.7136487688805, 929.8140371925608, 965.7344230336644, 968.0029569543382, 971.9416834989888, 974.055166488505, 976.0, 941.9387739796891, 946.7207173883686, 956.784723437228, 976.1068622210669, 977.1352353167463, 703.0157779109237, 705.9682314295869, 713.9357457828769, 726.9418446524265, 730.240549828178, 14790.556283311518, 14805.185714785683, 14827.962042657018, 14971.326290316962, 15041.398344066225, 11191.776164476747, 12971.67570810728, 13016.15394999322, 13179.934100329438, 13181.802272965913, 10062.849057264148, 10153.187744980383, 10183.083522483012, 10274.845877311845, 10531.578736850593, 3560.768550044239, 3561.3767590671528, 3563.429851223818, 3570.589382221026, 3669.1194113412857, 78798.60600697018, 78833.0, 79104.60447697724, 80097.0, 80437.79343309914, 9640.276979226586, 9648.903510964801, 9687.70936871895, 9738.269629777653, 9858.0, 21792.782072179394, 22398.104075836785, 22417.551648966928, 22627.66058509124, 22653.546929061657, 7665.0, 7720.227977202235, 7764.3788496920115, 7768.0678318601, 7853.607319633996, 4149.771762553029, 4150.315197992358, 4183.49798024239, 4287.464066991626, 4337.479502459725, 3623.239119784822, 3635.0003748969243, 3695.5750088740137, 3706.4625629283605, 3752.549694036733, 630.4893036640336, 641.4804008752925, 641.9197600299963, 653.434778916234, 654.7708302094229, 558.2324304081887, 597.6682940967804, 608.1060840564363, 612.0757655939564, 617.4967401567708, 7378.225286344964, 7847.529148251123, 8191.262786349257, 8372.120927302667, 8412.0, 548.347466514854, 568.9914651280234, 594.2215697436372, 608.5405518833253, 618.2179542878263, 3794.165283637595, 3872.3997780344093, 3888.6111388861455, 3934.2328245991757, 4054.493188351456, 70557.0, 88020.11979880248, 88310.1168988302, 88605.55697221601, 88782.66825997616, 69805.60388792196, 70178.9473157903, 73869.6306518464, 73877.0, 76784.0, 48596.0, 65145.34854651488, 67272.66363668151, 67898.0, 68474.65762671056, 7634.274743899321, 7666.846663066819, 7703.768886933401, 7736.651850666621, 7763.961180194063, 48069.27896081492, 48866.5113348862, 49931.75034124806, 50115.49884501108, 50329.0, 60437.0, 62686.74626507353, 68941.65529172322, 69114.65442672755, 71930.28069719445, 10179.847302290324, 10200.4389758564, 10258.333208341433, 10292.433916134685, 10434.947825260826, 10923.508442119964, 11065.059469945145, 11107.888921110685, 11273.943630281796, 11633.6509904703, 10282.588696452058, 10311.381317120697, 10334.276600637882, 10383.688489345332, 10558.0, 10170.89829101729, 10497.737556561147, 10786.784264314827, 10868.945655271673, 11484.885151148716, 10529.26295159362, 11440.256383335389, 11614.767704646029, 11778.52885884555, 11840.348780817138, 9741.756456088655, 9745.610175592898, 9779.856415145141, 9869.506524673881, 9920.454375009154, 9613.279004074582, 9780.16599914112, 9966.60133594677, 9973.152282056106, 9986.450745209084], "value": 6868.9058062176655, "unit": "score"}], "name": "dromaeo_css", "value": 7616.80844400488, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 118.0, 117.0, 120.0, 139.0, 163.0, 117.0, 118.0, 114.0], "value": 123.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 167.0, 157.0, 139.0, 168.0, 177.0, 121.0, 165.0, 120.0], "value": 149.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 198.0, 211.0, 233.0, 192.0, 194.0, 197.0, 197.0, 196.0, 194.0], "value": 200.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 80.0, 76.0, 169.0, 65.0, 57.0, 58.0, 67.0, 139.0, 82.0], "value": 86.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 123.0, 105.0, 94.0, 85.0, 115.0, 81.0, 79.0, 118.0], "value": 96.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 131.0, 133.0, 94.0, 94.0, 89.0, 110.0, 90.0, 89.0, 130.0], "value": 104.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 98.0, 97.0, 106.0, 151.0, 132.0, 103.0, 145.0, 111.0, 139.0], "value": 117.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 139.0, 113.0, 96.0, 94.0, 91.0, 91.0, 91.0, 91.0, 92.0], "value": 104.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 64.0, 64.0, 65.0, 66.0, 64.0, 78.0, 62.0, 60.0], "value": 64.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 92.0, 99.0, 103.0, 98.0, 74.0, 67.0, 83.0, 60.0, 61.0], "value": 80.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 96.0, 107.0, 84.0, 80.0, 80.0, 94.0, 103.0, 74.0, 104.0], "value": 90.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 127.0, 129.0, 126.0, 124.0, 125.0, 141.0, 150.0, 181.0, 150.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 163.0, 167.0, 166.0, 165.0, 160.0, 161.0, 164.0, 163.0, 183.0], "value": 166.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 66.0, 68.0, 66.0, 71.0, 66.0, 67.0, 70.0, 67.0, 65.0], "value": 67.8, "unit": "score"}], "name": "kraken", "value": 1589.7999999999997, "alertThreshold": 2.0}]} 04:29:58 INFO - Return code: 0 04:29:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:29:58 ERROR - # TBPL SUCCESS # 04:29:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:29:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:29:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:29:58 INFO - 2016-06-28 04:29:58.791 screenresolution[1676:10709] starting screenresolution argv=screenresolution get 04:29:58 INFO - 2016-06-28 04:29:58.793 screenresolution[1676:10709] Display 0: 1600x1200x32@60 04:29:58 INFO - 2016-06-28 04:29:58.799 screenresolution[1677:10712] starting screenresolution argv=screenresolution list 04:29:58 INFO - Available Modes on Display 0 04:29:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:29:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:29:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:29:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:29:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:29:59 INFO - Intel Iris: 04:29:59 INFO - Chipset Model: Intel Iris 04:29:59 INFO - Type: GPU 04:29:59 INFO - Bus: Built-In 04:29:59 INFO - VRAM (Dynamic, Max): 1536 MB 04:29:59 INFO - Vendor: Intel (0x8086) 04:29:59 INFO - Device ID: 0x0a2e 04:29:59 INFO - Revision ID: 0x0009 04:29:59 INFO - Displays: 04:29:59 INFO - Display: 04:29:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:29:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:29:59 INFO - Display Serial Number: 1600x1200 60 04:29:59 INFO - Main Display: Yes 04:29:59 INFO - Mirror: Off 04:29:59 INFO - Online: Yes 04:29:59 INFO - Rotation: Supported 04:29:59 INFO - Return code: 0 04:29:59 INFO - Running post-action listener: _resource_record_post_action 04:29:59 INFO - Running post-run listener: _resource_record_post_run 04:30:00 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 38221312; Write bytes: 495675392; Read time: 389; Write time: 1685 04:30:00 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 186065408; Write bytes: 186296320; Read time: 17324; Write time: 520 04:30:00 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 37299712; Write bytes: 299425792; Read time: 376; Write time: 1134 04:30:00 INFO - Running post-run listener: _upload_blobber_files 04:30:00 INFO - Blob upload gear active. 04:30:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:30:00 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 04:30:00 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'] 04:30:00 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 04:30:00 INFO - (blobuploader) - INFO - Open directory for files ... 04:30:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:30:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:30:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:01 INFO - (blobuploader) - INFO - Done attempting. 04:30:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:30:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:30:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:30:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:30:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:30:02 INFO - (blobuploader) - INFO - Done attempting. 04:30:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:30:02 INFO - Return code: 0 04:30:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:30:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:30:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4113fd546d2df52666f86f3a03cfb599f8082d59f68b0e8bf3f962999936124844ef12bbeb45975b50683952ef6eae6c9c66c481ca62b44dd9741ba6dfcabae2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f16f3a2157ef20f0ac0e43193acd636b9a99e28601e98d00a87b37393688be684e4c1255842d10cc2fb110cb3a65b8d215ba880589c6982ed894552b085186e3"} 04:30:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:30:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:30:02 INFO - Contents: 04:30:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4113fd546d2df52666f86f3a03cfb599f8082d59f68b0e8bf3f962999936124844ef12bbeb45975b50683952ef6eae6c9c66c481ca62b44dd9741ba6dfcabae2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f16f3a2157ef20f0ac0e43193acd636b9a99e28601e98d00a87b37393688be684e4c1255842d10cc2fb110cb3a65b8d215ba880589c6982ed894552b085186e3"} 04:30:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:30:02 INFO - Copying logs to upload dir... 04:30:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:30:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.507923 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-06-28 04:30:02.759449) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 04:30:02.763484) ========= 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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4113fd546d2df52666f86f3a03cfb599f8082d59f68b0e8bf3f962999936124844ef12bbeb45975b50683952ef6eae6c9c66c481ca62b44dd9741ba6dfcabae2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f16f3a2157ef20f0ac0e43193acd636b9a99e28601e98d00a87b37393688be684e4c1255842d10cc2fb110cb3a65b8d215ba880589c6982ed894552b085186e3"} build_url:https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011019 build_url: 'https://queue.taskcluster.net/v1/task/NVSE3rzTSKSKx46GLYfnEA/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4113fd546d2df52666f86f3a03cfb599f8082d59f68b0e8bf3f962999936124844ef12bbeb45975b50683952ef6eae6c9c66c481ca62b44dd9741ba6dfcabae2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f16f3a2157ef20f0ac0e43193acd636b9a99e28601e98d00a87b37393688be684e4c1255842d10cc2fb110cb3a65b8d215ba880589c6982ed894552b085186e3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-28 04:30:02.795649) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:30:02.795984) ========= 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.m3ZckvWEDn/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.mBAXwyEx9X/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005079 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-28 04:30:02.844906) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 04:30:02.845225) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-28 04:30:02.845549) ========= ========= Total master_lag: 0.91 =========