builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0084 starttime: 1489593161.93 results: success (0) buildid: 20170315081436 builduid: 65fc37f2961e43899a1a43e6828f8fee revision: ce8120111f7f2902b3ac88ac35773d9957714a7a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:41.934414) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:41.934935) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:41.935261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:41.962575) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:41.962994) ========= 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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 --2017-03-15 08:52:41-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.6M=0.001s 2017-03-15 08:52:42 (15.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142109 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:42.172792) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:42.173206) ========= 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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.030885 ========= master_lag: 0.84 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:43.047466) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 08:52:43.047922) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev ce8120111f7f2902b3ac88ac35773d9957714a7a --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-aurora --rev ce8120111f7f2902b3ac88ac35773d9957714a7a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 2017-03-15 08:52:43,119 truncating revision to first 12 chars 2017-03-15 08:52:43,119 Setting DEBUG logging. 2017-03-15 08:52:43,119 attempt 1/10 2017-03-15 08:52:43,119 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/ce8120111f7f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 08:52:44,292 unpacking tar archive at: mozilla-aurora-ce8120111f7f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.443869 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 08:52:44.516153) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:44.516539) ========= script_repo_revision: ce8120111f7f2902b3ac88ac35773d9957714a7a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:44.517134) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:44.517465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 08:52:44.538143) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-15 08:52:44.538819) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:52:44 INFO - MultiFileLogger online at 20170315 08:52:44 in /builds/slave/test 08:52:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 08:52:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:52:44 INFO - {'append_to_log': False, 08:52:44 INFO - 'base_work_dir': '/builds/slave/test', 08:52:44 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 08:52:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:52:44 INFO - 'branch': 'Mozilla-Aurora', 08:52:44 INFO - 'buildbot_json_path': 'buildprops.json', 08:52:44 INFO - 'config_files': ('talos/mac_config.py',), 08:52:44 INFO - 'default_actions': ('clobber', 08:52:44 INFO - 'read-buildbot-config', 08:52:44 INFO - 'download-and-extract', 08:52:44 INFO - 'populate-webroot', 08:52:44 INFO - 'create-virtualenv', 08:52:44 INFO - 'install', 08:52:44 INFO - 'run-tests'), 08:52:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:52:44 INFO - 'download_minidump_stackwalk': True, 08:52:44 INFO - 'download_symbols': 'ondemand', 08:52:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:52:44 INFO - 'tooltool.py': '/tools/tooltool.py', 08:52:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:52:44 INFO - '/tools/misc-python/virtualenv.py')}, 08:52:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:52:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:52:44 INFO - 'gecko_profile': False, 08:52:44 INFO - 'gecko_profile_interval': 0, 08:52:44 INFO - 'installer_path': 'installer.exe', 08:52:44 INFO - 'log_level': 'info', 08:52:44 INFO - 'log_name': 'talos', 08:52:44 INFO - 'log_to_console': True, 08:52:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:52:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:52:44 INFO - 'opt_config_files': (), 08:52:44 INFO - 'pip_index': False, 08:52:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:44 INFO - 'cmd': ('bash', 08:52:44 INFO - '-c', 08:52:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:44 INFO - 'enabled': True, 08:52:44 INFO - 'halt_on_failure': False, 08:52:44 INFO - 'name': 'check_screen_resolution'},), 08:52:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:52:44 INFO - 'cmd': ('bash', 08:52:44 INFO - '-c', 08:52:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:52:44 INFO - 'enabled': True, 08:52:44 INFO - 'halt_on_failure': False, 08:52:44 INFO - 'name': 'check_screen_resolution'},), 08:52:44 INFO - 'run_cmd_checks_enabled': True, 08:52:44 INFO - 'suite': 'dromaeojs', 08:52:44 INFO - 'system_bits': '32', 08:52:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:52:44 INFO - 'title': 't-yosemite-r7-0084', 08:52:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:52:44 INFO - 'use_talos_json': True, 08:52:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:52:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:52:44 INFO - 'work_dir': 'build'} 08:52:44 INFO - [mozharness: 2017-03-15 15:52:44.720095Z] Running clobber step. 08:52:44 INFO - Running pre-action listener: _resource_record_pre_action 08:52:44 INFO - Running main action method: clobber 08:52:44 INFO - rmtree: /builds/slave/test/build 08:52:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:52:47 INFO - Running post-action listener: _resource_record_post_action 08:52:47 INFO - [mozharness: 2017-03-15 15:52:47.316811Z] Finished clobber step (success) 08:52:47 INFO - [mozharness: 2017-03-15 15:52:47.316932Z] Running read-buildbot-config step. 08:52:47 INFO - Running pre-action listener: _resource_record_pre_action 08:52:47 INFO - Running main action method: read_buildbot_config 08:52:47 INFO - Using buildbot properties: 08:52:47 INFO - { 08:52:47 INFO - "project": "", 08:52:47 INFO - "product": "firefox", 08:52:47 INFO - "script_repo_revision": "production", 08:52:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 08:52:47 INFO - "repository": "", 08:52:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 08:52:47 INFO - "buildid": "20170315081436", 08:52:47 INFO - "pgo_build": "False", 08:52:47 INFO - "basedir": "/builds/slave/test", 08:52:47 INFO - "buildnumber": 91, 08:52:47 INFO - "slavename": "t-yosemite-r7-0084", 08:52:47 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 08:52:47 INFO - "platform": "yosemite_r7", 08:52:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 08:52:47 INFO - "branch": "mozilla-aurora", 08:52:47 INFO - "repo_path": "releases/mozilla-aurora", 08:52:47 INFO - "revision": "ce8120111f7f2902b3ac88ac35773d9957714a7a", 08:52:47 INFO - "stage_platform": "macosx64", 08:52:47 INFO - "builduid": "65fc37f2961e43899a1a43e6828f8fee", 08:52:47 INFO - "slavebuilddir": "test" 08:52:47 INFO - } 08:52:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 08:52:47 INFO - Running post-action listener: _resource_record_post_action 08:52:47 INFO - [mozharness: 2017-03-15 15:52:47.320147Z] Finished read-buildbot-config step (success) 08:52:47 INFO - [mozharness: 2017-03-15 15:52:47.320252Z] Running download-and-extract step. 08:52:47 INFO - Running pre-action listener: _resource_record_pre_action 08:52:47 INFO - Running main action method: download_and_extract 08:52:47 INFO - mkdir: /builds/slave/test/build/tests 08:52:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:47 INFO - trying https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 08:52:47 INFO - Downloading https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 08:52:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 08:52:48 INFO - Downloaded 1199 bytes. 08:52:48 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 08:52:48 INFO - Using the following test package requirements: 08:52:48 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:52:48 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:52:48 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 08:52:48 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:52:48 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 08:52:48 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:52:48 INFO - u'jsshell-mac.zip'], 08:52:48 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:52:48 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 08:52:48 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 08:52:48 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:52:48 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 08:52:48 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:52:48 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 08:52:48 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:52:48 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 08:52:48 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 08:52:48 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 08:52:48 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 08:52:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:52:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:52:48 INFO - Fetch https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:52:50 INFO - Expected file size: 51781594 08:52:50 INFO - Obtained file size: 51781594 08:53:06 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 08:53:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 08:53:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 08:53:06 INFO - Fetch https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 08:53:07 INFO - Expected file size: 51781594 08:53:07 INFO - Obtained file size: 51781594 08:53:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 08:53:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 08:53:23 INFO - Fetch https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 08:53:23 INFO - Expected file size: 14404424 08:53:23 INFO - Obtained file size: 14404424 08:53:24 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:24 INFO - trying https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:53:24 INFO - Downloading https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 08:53:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 08:53:27 INFO - Downloaded 74622355 bytes. 08:53:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:53:27 INFO - mkdir: /builds/slave/test/properties 08:53:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:27 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:27 INFO - Contents: 08:53:27 INFO - build_url:https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 08:53:27 INFO - Running post-action listener: _resource_record_post_action 08:53:27 INFO - Running post-action listener: set_extra_try_arguments 08:53:27 INFO - [mozharness: 2017-03-15 15:53:27.951953Z] Finished download-and-extract step (success) 08:53:27 INFO - [mozharness: 2017-03-15 15:53:27.952081Z] Running populate-webroot step. 08:53:27 INFO - Running pre-action listener: _resource_record_pre_action 08:53:27 INFO - Running main action method: populate_webroot 08:53:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:27 INFO - '--tppagecycles', 08:53:27 INFO - '7'], 08:53:27 INFO - 'tests': ['tsvgm']}}, 08:53:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:53:27 INFO - 'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:53:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:53:27 INFO - 'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['damp', 'tps']}, 08:53:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:53:27 INFO - 'tests': ['damp', 'tps']}, 08:53:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['dromaeo_dom']}, 08:53:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['basic_compositor_video']}, 08:53:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:53:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['a11yr', 08:53:27 INFO - 'ts_paint', 08:53:27 INFO - 'tpaint', 08:53:27 INFO - 'sessionrestore', 08:53:27 INFO - 'sessionrestore_no_auto_restore', 08:53:27 INFO - 'tabpaint']}, 08:53:27 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:27 INFO - 'ts_paint', 08:53:27 INFO - 'tpaint', 08:53:27 INFO - 'sessionrestore', 08:53:27 INFO - 'sessionrestore_no_auto_restore', 08:53:27 INFO - 'tabpaint']}, 08:53:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:27 INFO - 'ts_paint', 08:53:27 INFO - 'tpaint', 08:53:27 INFO - 'sessionrestore', 08:53:27 INFO - 'sessionrestore_no_auto_restore', 08:53:27 INFO - 'tabpaint']}, 08:53:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:27 INFO - 'ts_paint', 08:53:27 INFO - 'tpaint', 08:53:27 INFO - 'sessionrestore', 08:53:27 INFO - 'sessionrestore_no_auto_restore', 08:53:27 INFO - 'tabpaint']}, 08:53:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['a11yr', 08:53:27 INFO - 'ts_paint', 08:53:27 INFO - 'tpaint', 08:53:27 INFO - 'sessionrestore', 08:53:27 INFO - 'sessionrestore_no_auto_restore', 08:53:27 INFO - 'tabpaint']}, 08:53:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['a11yr', 08:53:27 INFO - 'ts_paint', 08:53:27 INFO - 'tpaint', 08:53:27 INFO - 'sessionrestore', 08:53:27 INFO - 'sessionrestore_no_auto_restore', 08:53:27 INFO - 'tabpaint']}, 08:53:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['tsvgx', 08:53:27 INFO - 'tsvgr_opacity', 08:53:27 INFO - 'tart', 08:53:27 INFO - 'tscrollx', 08:53:27 INFO - 'cart', 08:53:27 INFO - 'tsvg_static']}, 08:53:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:27 INFO - 'tsvgr_opacity', 08:53:27 INFO - 'tart', 08:53:27 INFO - 'tscrollx', 08:53:27 INFO - 'cart', 08:53:27 INFO - 'tsvg_static']}, 08:53:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:53:27 INFO - 'talos_options': ['--disable-e10s'], 08:53:27 INFO - 'tests': ['tp5o']}, 08:53:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:53:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:53:27 INFO - 'talos_options': ['--disable-e10s', 08:53:27 INFO - '--xperf_path', 08:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:27 INFO - 'tests': ['tp5n']}, 08:53:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:53:27 INFO - 'talos_options': ['--xperf_path', 08:53:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:27 INFO - 'tests': ['tp5n']}}, 08:53:27 INFO - 'talos.zip': {'path': '', 08:53:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:27 INFO - Running post-action listener: _resource_record_post_action 08:53:27 INFO - [mozharness: 2017-03-15 15:53:27.970102Z] Finished populate-webroot step (success) 08:53:27 INFO - [mozharness: 2017-03-15 15:53:27.970214Z] Running create-virtualenv step. 08:53:27 INFO - Running pre-action listener: _resource_record_pre_action 08:53:27 INFO - Running main action method: create_virtualenv 08:53:27 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:27 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 08:53:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:28 INFO - Using real prefix '/tools/python27' 08:53:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:28 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:31 INFO - Installing pip.................done. 08:53:31 INFO - Return code: 0 08:53:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:53:31 INFO - Reading from file tmpfile_stdout 08:53:31 INFO - Output received: 08:53:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:53:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:53: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', 'pip>=1.5'] in /builds/slave/test/build 08:53: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 pip>=1.5 08:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:32 INFO - 'HOME': '/Users/cltbld', 08:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:32 INFO - 'LOGNAME': 'cltbld', 08:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:32 INFO - 'MOZ_NO_REMOTE': '1', 08:53:32 INFO - 'NO_EM_RESTART': '1', 08:53:32 INFO - 'PAGER': '/bin/cat', 08:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:32 INFO - 'PWD': '/builds/slave/test', 08:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:32 INFO - 'SHELL': '/bin/bash', 08:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:53:32 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:32 INFO - 'USER': 'cltbld', 08:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:32 INFO - 'XPC_FLAGS': '0x0', 08:53:32 INFO - 'XPC_SERVICE_NAME': '0', 08:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:33 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 08:53:33 INFO - Cleaning up... 08:53:33 INFO - Return code: 0 08:53:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:33 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:53:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:53:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:53:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:33 INFO - 'HOME': '/Users/cltbld', 08:53:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:33 INFO - 'LOGNAME': 'cltbld', 08:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:33 INFO - 'MOZ_NO_REMOTE': '1', 08:53:33 INFO - 'NO_EM_RESTART': '1', 08:53:33 INFO - 'PAGER': '/bin/cat', 08:53:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:33 INFO - 'PWD': '/builds/slave/test', 08:53:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:33 INFO - 'SHELL': '/bin/bash', 08:53:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:53:33 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:53:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:33 INFO - 'USER': 'cltbld', 08:53:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:33 INFO - 'XPC_FLAGS': '0x0', 08:53:33 INFO - 'XPC_SERVICE_NAME': '0', 08:53:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:33 INFO - Downloading/unpacking psutil>=3.1.1 08:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:37 INFO - Installing collected packages: psutil 08:53:37 INFO - Running setup.py install for psutil 08:53:37 INFO - building 'psutil._psutil_osx' extension 08:53:37 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 08:53:38 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 08:53:38 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 08:53:38 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 08:53:38 INFO - building 'psutil._psutil_posix' extension 08:53:38 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 08:53:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:53:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:53:38 INFO - ^ 08:53:38 INFO - 1 warning generated. 08:53:38 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 08:53:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:38 INFO - Successfully installed psutil 08:53:38 INFO - Cleaning up... 08:53:38 INFO - Return code: 0 08:53:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:38 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:53:38 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.3'] in /builds/slave/test/build 08:53:38 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.3 08:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:38 INFO - 'HOME': '/Users/cltbld', 08:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:38 INFO - 'LOGNAME': 'cltbld', 08:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:38 INFO - 'MOZ_NO_REMOTE': '1', 08:53:38 INFO - 'NO_EM_RESTART': '1', 08:53:38 INFO - 'PAGER': '/bin/cat', 08:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:38 INFO - 'PWD': '/builds/slave/test', 08:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:38 INFO - 'SHELL': '/bin/bash', 08:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:53:38 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:38 INFO - 'USER': 'cltbld', 08:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:38 INFO - 'XPC_FLAGS': '0x0', 08:53:38 INFO - 'XPC_SERVICE_NAME': '0', 08:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:41 INFO - Installing collected packages: mozsystemmonitor 08:53:41 INFO - Running setup.py install for mozsystemmonitor 08:53:41 INFO - Successfully installed mozsystemmonitor 08:53:41 INFO - Cleaning up... 08:53:42 INFO - Return code: 0 08:53:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:42 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:42 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:53:42 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==2.5.1'] in /builds/slave/test/build 08:53:42 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==2.5.1 08:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:42 INFO - 'HOME': '/Users/cltbld', 08:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:42 INFO - 'LOGNAME': 'cltbld', 08:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:42 INFO - 'MOZ_NO_REMOTE': '1', 08:53:42 INFO - 'NO_EM_RESTART': '1', 08:53:42 INFO - 'PAGER': '/bin/cat', 08:53:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:42 INFO - 'PWD': '/builds/slave/test', 08:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:42 INFO - 'SHELL': '/bin/bash', 08:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:53:42 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:42 INFO - 'USER': 'cltbld', 08:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:42 INFO - 'XPC_FLAGS': '0x0', 08:53:42 INFO - 'XPC_SERVICE_NAME': '0', 08:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:42 INFO - Downloading/unpacking jsonschema==2.5.1 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53: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 08:53:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53:44 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 08:53:44 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 08:53:44 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 08:53:44 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 08:53:44 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 08:53:44 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 08:53:45 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:45 INFO - warning: no files found matching '*.txt' 08:53:45 INFO - no previously-included directories found matching 'build' 08:53:45 INFO - no previously-included directories found matching 'dist' 08:53:45 INFO - no previously-included directories found matching '.git*' 08:53:45 INFO - Installing collected packages: jsonschema, functools32 08:53:45 INFO - Running setup.py install for functools32 08:53:45 INFO - warning: no files found matching '*.txt' 08:53:45 INFO - no previously-included directories found matching 'build' 08:53:45 INFO - no previously-included directories found matching 'dist' 08:53:45 INFO - no previously-included directories found matching '.git*' 08:53:45 INFO - Successfully installed jsonschema functools32 08:53:45 INFO - Cleaning up... 08:53:45 INFO - Return code: 0 08:53:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:45 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:53:45 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:53:45 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 functools32==3.2.3-2 08:53:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:53:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:45 INFO - 'HOME': '/Users/cltbld', 08:53:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:45 INFO - 'LOGNAME': 'cltbld', 08:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:45 INFO - 'MOZ_NO_REMOTE': '1', 08:53:45 INFO - 'NO_EM_RESTART': '1', 08:53:45 INFO - 'PAGER': '/bin/cat', 08:53:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:45 INFO - 'PWD': '/builds/slave/test', 08:53:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:45 INFO - 'SHELL': '/bin/bash', 08:53:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:53:45 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:53:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:45 INFO - 'USER': 'cltbld', 08:53:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:45 INFO - 'XPC_FLAGS': '0x0', 08:53:45 INFO - 'XPC_SERVICE_NAME': '0', 08:53:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:45 INFO - Cleaning up... 08:53:45 INFO - Return code: 0 08:53:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:45 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 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:53:45 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 08:53:45 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 08:53:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:53:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:45 INFO - 'HOME': '/Users/cltbld', 08:53:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:45 INFO - 'LOGNAME': 'cltbld', 08:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:45 INFO - 'MOZ_NO_REMOTE': '1', 08:53:45 INFO - 'NO_EM_RESTART': '1', 08:53:45 INFO - 'PAGER': '/bin/cat', 08:53:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:45 INFO - 'PWD': '/builds/slave/test', 08:53:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:45 INFO - 'SHELL': '/bin/bash', 08:53:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:53:45 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:53:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:45 INFO - 'USER': 'cltbld', 08:53:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:45 INFO - 'XPC_FLAGS': '0x0', 08:53:45 INFO - 'XPC_SERVICE_NAME': '0', 08:53:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:46 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:46 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 08:53:46 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 08:53:46 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 08:53:46 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 08:53:46 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 08:53:46 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 08:53:48 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:48 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 08:53:48 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 08:53:48 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 08:53:48 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 08:53:48 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 08:53:48 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 08:53:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:50 INFO - Downloading docopt-0.6.1.tar.gz 08:53:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:50 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:50 INFO - Running setup.py install for blobuploader 08:53:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:50 INFO - Running setup.py install for requests 08:53:50 INFO - Running setup.py install for docopt 08:53:50 INFO - Successfully installed blobuploader requests docopt 08:53:50 INFO - Cleaning up... 08:53:51 INFO - Return code: 0 08:53:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:51 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:51 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 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:53:51 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 08:53:51 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 08:53:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:53:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:51 INFO - 'HOME': '/Users/cltbld', 08:53:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:51 INFO - 'LOGNAME': 'cltbld', 08:53:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:51 INFO - 'MOZ_NO_REMOTE': '1', 08:53:51 INFO - 'NO_EM_RESTART': '1', 08:53:51 INFO - 'PAGER': '/bin/cat', 08:53:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:51 INFO - 'PWD': '/builds/slave/test', 08:53:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:51 INFO - 'SHELL': '/bin/bash', 08:53:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:53:51 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:53:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:51 INFO - 'USER': 'cltbld', 08:53:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:51 INFO - 'XPC_FLAGS': '0x0', 08:53:51 INFO - 'XPC_SERVICE_NAME': '0', 08:53:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-4xVtK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-etsC8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-MlN_AG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-0YLAHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-y22yYj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xs2lOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:51 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-CaUkJs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-eeTXeM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-p1_7qw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xs6Wi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-EWCWQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-NMYIgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-2HsfYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-ntVr8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-usPNiM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:52 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-NhkXTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:53 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-HbqDAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:53 INFO - Running setup.py install for manifestparser 08:53:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:53 INFO - Running setup.py install for mozcrash 08:53:53 INFO - Running setup.py install for mozdebug 08:53:53 INFO - Running setup.py install for mozdevice 08:53:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:53 INFO - Running setup.py install for mozfile 08:53:53 INFO - Running setup.py install for mozhttpd 08:53:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:54 INFO - Running setup.py install for mozinfo 08:53:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:54 INFO - Running setup.py install for mozInstall 08:53:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:54 INFO - Running setup.py install for mozleak 08:53:54 INFO - Running setup.py install for mozlog 08:53:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:54 INFO - Running setup.py install for moznetwork 08:53:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:54 INFO - Running setup.py install for mozprocess 08:53:54 INFO - Running setup.py install for mozprofile 08:53:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:55 INFO - Running setup.py install for mozrunner 08:53:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:55 INFO - Running setup.py install for mozscreenshot 08:53:55 INFO - Running setup.py install for moztest 08:53:55 INFO - Running setup.py install for mozversion 08:53:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:55 INFO - Cleaning up... 08:53:55 INFO - Return code: 0 08:53:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:55 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:55 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 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:53:55 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 08:53:55 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 08:53:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:53:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:53:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:53:55 INFO - 'HOME': '/Users/cltbld', 08:53:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:53:55 INFO - 'LOGNAME': 'cltbld', 08:53:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:55 INFO - 'MOZ_NO_REMOTE': '1', 08:53:55 INFO - 'NO_EM_RESTART': '1', 08:53:55 INFO - 'PAGER': '/bin/cat', 08:53:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:53:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:55 INFO - 'PWD': '/builds/slave/test', 08:53:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:53:55 INFO - 'SHELL': '/bin/bash', 08:53:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:53:55 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:53:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:53:55 INFO - 'USER': 'cltbld', 08:53:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:53:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:53:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:55 INFO - 'XPC_FLAGS': '0x0', 08:53:55 INFO - 'XPC_SERVICE_NAME': '0', 08:53:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:53:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:55 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-AwKYtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:56 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)) 08:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-s4ahjs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 08:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-LRUM8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:56 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)) 08:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-uJLBED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 08:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-L7t0wv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:56 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)) 08:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-dsaAWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:56 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)) 08:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-Wdcxb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:56 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)) 08:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-lzrJnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:56 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)) 08:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-PPmocP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:56 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)) 08:53:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:56 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-jpRvw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 08:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-QO3aeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:57 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)) 08:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xrwUDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 08:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-0B_zfE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:57 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)) 08:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-xRHqm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 08:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-IJRRZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:57 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)) 08:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-M0pEns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 08:53:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:57 INFO - Running setup.py (path:/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/pip-KnxhNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:57 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)) 08:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:53:57 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)) 08:53:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:57 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:53:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:00 INFO - Downloading blessings-1.6.tar.gz 08:54:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:54:00 INFO - Installing collected packages: blessings 08:54:00 INFO - Running setup.py install for blessings 08:54:00 INFO - Successfully installed blessings 08:54:00 INFO - Cleaning up... 08:54:00 INFO - Return code: 0 08:54:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:54:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:01 INFO - Reading from file tmpfile_stdout 08:54:01 INFO - Current package versions: 08:54:01 INFO - blessings == 1.6 08:54:01 INFO - blobuploader == 1.2.4 08:54:01 INFO - docopt == 0.6.1 08:54:01 INFO - functools32 == 3.2.3-2 08:54:01 INFO - jsonschema == 2.5.1 08:54:01 INFO - manifestparser == 1.1 08:54:01 INFO - mozInstall == 1.12 08:54:01 INFO - mozcrash == 1.0 08:54:01 INFO - mozdebug == 0.1 08:54:01 INFO - mozdevice == 0.49 08:54:01 INFO - mozfile == 1.2 08:54:01 INFO - mozhttpd == 0.7 08:54:01 INFO - mozinfo == 0.9 08:54:01 INFO - mozleak == 0.1 08:54:01 INFO - mozlog == 3.4 08:54:01 INFO - moznetwork == 0.27 08:54:01 INFO - mozprocess == 0.25 08:54:01 INFO - mozprofile == 0.28 08:54:01 INFO - mozrunner == 6.13 08:54:01 INFO - mozscreenshot == 0.1 08:54:01 INFO - mozsystemmonitor == 0.3 08:54:01 INFO - moztest == 0.8 08:54:01 INFO - mozversion == 1.4 08:54:01 INFO - psutil == 3.1.1 08:54:01 INFO - requests == 1.2.3 08:54:01 INFO - wsgiref == 0.1.2 08:54:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:01 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 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:54:01 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 08:54:01 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 08:54:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:54:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:01 INFO - 'HOME': '/Users/cltbld', 08:54:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:01 INFO - 'LOGNAME': 'cltbld', 08:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:01 INFO - 'MOZ_NO_REMOTE': '1', 08:54:01 INFO - 'NO_EM_RESTART': '1', 08:54:01 INFO - 'PAGER': '/bin/cat', 08:54:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:01 INFO - 'PWD': '/builds/slave/test', 08:54:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:01 INFO - 'SHELL': '/bin/bash', 08:54:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:54:01 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:54:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:01 INFO - 'USER': 'cltbld', 08:54:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:01 INFO - 'XPC_FLAGS': '0x0', 08:54:01 INFO - 'XPC_SERVICE_NAME': '0', 08:54:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:01 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)) 08:54:01 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)) 08:54:01 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)) 08:54:01 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)) 08:54:01 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)) 08:54:01 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)) 08:54:01 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)) 08:54:01 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)) 08:54:01 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)) 08:54:01 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)) 08:54:01 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)) 08:54:01 INFO - Cleaning up... 08:54:01 INFO - Return code: 0 08:54:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:54:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:01 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:01 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 0x1056dab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1056dd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc238571370>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, '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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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 08:54:01 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 08:54:01 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 08:54:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:54:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:01 INFO - 'HOME': '/Users/cltbld', 08:54:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:01 INFO - 'LOGNAME': 'cltbld', 08:54:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:01 INFO - 'MOZ_NO_REMOTE': '1', 08:54:01 INFO - 'NO_EM_RESTART': '1', 08:54:01 INFO - 'PAGER': '/bin/cat', 08:54:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:01 INFO - 'PWD': '/builds/slave/test', 08:54:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:01 INFO - 'SHELL': '/bin/bash', 08:54:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:54:01 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:54:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:01 INFO - 'USER': 'cltbld', 08:54:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:01 INFO - 'XPC_FLAGS': '0x0', 08:54:01 INFO - 'XPC_SERVICE_NAME': '0', 08:54:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:54:01 INFO - Cleaning up... 08:54:01 INFO - Return code: 0 08:54:01 INFO - Running post-action listener: _resource_record_post_action 08:54:01 INFO - Running post-action listener: _start_resource_monitoring 08:54:01 INFO - Starting resource monitoring. 08:54:01 INFO - [mozharness: 2017-03-15 15:54:01.664360Z] Finished create-virtualenv step (success) 08:54:01 INFO - [mozharness: 2017-03-15 15:54:01.665342Z] Running install step. 08:54:01 INFO - Running pre-action listener: _resource_record_pre_action 08:54:01 INFO - Running main action method: install 08:54:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:54:01 INFO - Reading from file tmpfile_stdout 08:54:01 INFO - Detecting whether we're running mozinstall >=1.0... 08:54:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:54:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:54:02 INFO - Reading from file tmpfile_stdout 08:54:02 INFO - Output received: 08:54:02 INFO - Usage: mozinstall [options] installer 08:54:02 INFO - Options: 08:54:02 INFO - -h, --help show this help message and exit 08:54:02 INFO - -d DEST, --destination=DEST 08:54:02 INFO - Directory to install application into. [default: 08:54:02 INFO - "/builds/slave/test"] 08:54:02 INFO - --app=APP Application being installed. [default: firefox] 08:54:02 INFO - mkdir: /builds/slave/test/build/application 08:54:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 08:54:22 INFO - Reading from file tmpfile_stdout 08:54:22 INFO - Output received: 08:54:22 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 08:54:22 INFO - Running post-action listener: _resource_record_post_action 08:54:22 INFO - [mozharness: 2017-03-15 15:54:22.669114Z] Finished install step (success) 08:54:22 INFO - [mozharness: 2017-03-15 15:54:22.669274Z] Running run-tests step. 08:54:22 INFO - Running pre-action listener: _resource_record_pre_action 08:54:22 INFO - Running main action method: run_tests 08:54:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:54:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:54:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:54:22 INFO - 2017-03-15 08:54:22.684 screenresolution[1635:7560] starting screenresolution argv=screenresolution get 08:54:22 INFO - 2017-03-15 08:54:22.686 screenresolution[1635:7560] Display 0: 1600x1200x32@60 08:54:22 INFO - 2017-03-15 08:54:22.692 screenresolution[1636:7562] starting screenresolution argv=screenresolution list 08:54:22 INFO - Available Modes on Display 0 08:54:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:54:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:54:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:54:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:54:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:54:22 INFO - Intel Iris: 08:54:22 INFO - Chipset Model: Intel Iris 08:54:22 INFO - Type: GPU 08:54:22 INFO - Bus: Built-In 08:54:22 INFO - VRAM (Dynamic, Max): 1536 MB 08:54:22 INFO - Vendor: Intel (0x8086) 08:54:22 INFO - Device ID: 0x0a2e 08:54:22 INFO - Revision ID: 0x0009 08:54:22 INFO - Displays: 08:54:22 INFO - Display: 08:54:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:54:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:54:22 INFO - Display Serial Number: 1600x1200 60 08:54:22 INFO - Main Display: Yes 08:54:22 INFO - Mirror: Off 08:54:22 INFO - Online: Yes 08:54:22 INFO - Rotation: Supported 08:54:22 INFO - Return code: 0 08:54:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:22 INFO - Python 2.7.3 08:54:22 INFO - Return code: 0 08:54:22 INFO - grabbing minidump binary from tooltool 08:54:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:22 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: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1054b8d30>, '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 0x1053dfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1054adbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:22 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 08:54:22 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 08:54:22 INFO - Calling ['/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'] with output_timeout 600 08:54:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:23 INFO - Return code: 0 08:54:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:54:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:23 INFO - ENV: RUST_BACKTRACE is now 1 08:54:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:54:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:54:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0084 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:54:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.hKXSJkjpQv/Render', 08:54:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:54:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:54:23 INFO - 'HOME': '/Users/cltbld', 08:54:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:54:23 INFO - 'LOGNAME': 'cltbld', 08:54:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:54:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:23 INFO - 'MOZ_NO_REMOTE': '1', 08:54:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:23 INFO - 'NO_EM_RESTART': '1', 08:54:23 INFO - 'PAGER': '/bin/cat', 08:54:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:54:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:23 INFO - 'PWD': '/builds/slave/test', 08:54:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:54:23 INFO - 'RUST_BACKTRACE': '1', 08:54:23 INFO - 'SHELL': '/bin/bash', 08:54:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.JCbpJeJ4wI/Listeners', 08:54:23 INFO - 'TMPDIR': '/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/', 08:54:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:54:23 INFO - 'USER': 'cltbld', 08:54:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:54:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:54:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:23 INFO - 'XPC_FLAGS': '0x0', 08:54:23 INFO - 'XPC_SERVICE_NAME': '0', 08:54:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:54:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0084', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:54:23 INFO - mozversion application_buildid: 20170315081436 08:54:23 INFO - mozversion application_changeset: ce8120111f7f2902b3ac88ac35773d9957714a7a 08:54:23 INFO - mozversion application_display_name: FirefoxDeveloperEdition 08:54:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:23 INFO - mozversion application_name: Firefox 08:54:23 INFO - mozversion application_remotingname: firefox-dev 08:54:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:54:23 INFO - mozversion application_vendor: Mozilla 08:54:23 INFO - mozversion application_version: 54.0a2 08:54:23 INFO - mozversion platform_buildid: 20170315081436 08:54:23 INFO - mozversion platform_changeset: ce8120111f7f2902b3ac88ac35773d9957714a7a 08:54:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 08:54:23 INFO - mozversion platform_version: 54.0a2 08:54:23 INFO - using testdate: 1489593263 08:54:23 INFO - actual date: 1489593263 08:54:23 INFO - starting webserver on 'localhost:49250' 08:54:23 INFO - SUITE-START | Running 2 tests 08:54:23 INFO - TEST-START | dromaeo_css 08:54:23 INFO - operating with platform_type : mac_ 08:54:23 INFO - Initialising browser for dromaeo_css test... 08:54:23 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpSZ4Kmq/profile http://localhost:49250/getInfo.html) 08:54:26 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 08:54:26 INFO - PROCESS | 1646 | colorDepth:24 08:54:26 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 08:54:26 INFO - PROCESS | 1646 | __metrics 08:54:26 INFO - PROCESS | 1646 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:54:26 INFO - PROCESS | 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:54:27 INFO - TEST-INFO | 1646: exit 0 08:54:27 INFO - Browser initialized. 08:54:27 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:27 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmpSZ4Kmq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:39 INFO - PROCESS | 1648 | RSS: Main: 214573056 08:54:39 INFO - PROCESS | 1648 | 08:57:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 08:57:45 INFO - PROCESS | 1648 | RSS: Main: 390062080 08:57:45 INFO - PROCESS | 1648 | 08:59:28 INFO - PROCESS | 1648 | ************************* 08:59:28 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 08:59:28 INFO - PROCESS | 1648 | 08:59:28 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:59:28 INFO - PROCESS | 1648 | Full stack: 08:59:28 INFO - PROCESS | 1648 | ************************* 09:00:48 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 09:00:49 INFO - PROCESS | 1648 | RSS: Main: 352137216 09:00:49 INFO - PROCESS | 1648 | 09:03:51 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 09:03:52 INFO - PROCESS | 1648 | RSS: Main: 338067456 09:03:52 INFO - PROCESS | 1648 | 09:06:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 09:06:55 INFO - PROCESS | 1648 | RSS: Main: 322469888 09:06:55 INFO - PROCESS | 1648 | 09:09:59 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 09:09:59 INFO - PROCESS | 1648 | RSS: Main: 328323072 09:09:59 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 09:13:03 INFO - PROCESS | 1648 | RSS: Main: 466997248 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | __start_tp_report 09:13:03 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 09:13:03 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 09:13:03 INFO - PROCESS | 1648 | |i|pagename|runs| 09:13:03 INFO - PROCESS | 1648 | |0;dojo.html;3418.675225853543;3420.692137707606;3440.071180781189;3446.3279660466205;3468.4797280407934;5962.403759624035;5979.63551462481;6011.308699499548;6081.0878368244785;6099.5120390368775;5974.31295401029;6051.7276722547485;6061.9696901515545;6068.726907289171;6070.089486577016;5373.623846330749;5404.864878378053;5406.053940560406;5416.783328666848;5513.531349835269;5331.760070796823;5344.652597581165;5505.229267902497;5510.228568000483;5577.776888924438;5346.679199248058;5390.6226564140525;5417.024935511607;5424;5428.4842939920845;5401.540869026137;5410.972945135289;5412.9458705413035;5416.322959630046;5425;3890.747101438426;5270.8155214567305;5368.114261146906;5377.0321342158395;5385.5960802939935;6019.458248757633;6023.6385816851125;6032.245969253843;6034.064719968412;6035.486983606399;6228.5951413158;6232.688365581748;6239.625622462667;6246.781362652331;6251.9687401562705;5286.550643195333;6266.937330626681;6270.247570291549;6294.968525157391;6341.143945567382;5010.4739002404585;6093.11649810775;6101.0848372744;6112.7249273782345;6130.570860039799;6517.9674101630135;6520.11978382917;6569.146011018537;6572.474202063823;6594.439472644831;6121.755129794848;6151.200343955346;6210.844728881723;6218.782342617987;6223;6193.380661933861;6236.6258024518675;6245.750169993149;6252.562320637603;6342.778002769973;6280.309165991737;6327.145835312266;6329.778457754049;6346.30190679025;6350.8412289692205;6333.588316759488;6339.587926784837;6346.777862774781;6349.142865713162;6349.777757778455;5000;5023.824166154167;5088.949110508847;5137.717425541557;5207.479252074762;4187.45563076798;4533.116042371706;4575.199340115533;4596.954030459719;4621.653375996813;5038.84883453497;6039.969800150971;6106.297775755845;6118.357572454917;6134.44789968896;6179.227596550431;6242.469390101802;6429.292777794439;6451.870962580722;6455.741770329134;5964.7912323068485;6068.937935861207;6097.512199024068;6099.451049405486;6106.145139680449;5672.517835983987;5673.858153546112;5674.092145256739;5674.744636491368;5678.261825962599;6613.603183808795;6638.966805165944;6663;6664.366885145903;6678.53250272486;6135.5082808396355;6212.409821066992;6253.312135664983;6257.186565746424;6270.153529273673;6444.065610486359;6460;6463.450606698483;6468.482521398183;6485.416312531895;6288.056791481132;6317.399847014526;6330.968345158245;6353.237611486651;6359.332270111757;6378.138951241523;6392.64840433762;6396.264429590657;6398;6410.134631824644;6117.796956032775;6252.906206406817;6256.155419018374;6263.686815659108;6274.435300822948;6158.876822463615;6181.196444462191;6222;6254.781082662085;6267.905981410191;6227.470664993526;6255.499560035095;6265.060240963892;6269.717862696099;6279;6239.06414037898;6245.500359971283;6249.34381889895;6255.218097737783;6273.780417685359;6025.216721826135;6098.871708733898;6109.7387008107025;6126.151269885628;6152.077188421773 09:13:03 INFO - PROCESS | 1648 | |1;ext.html;743.4758495260842;767.6353731977312;811.8701007838747;862.3704695572233;881.4799268431632;27618;39293.01767455815;39714;39814.99999999996;39838.60161398393;33176.502352464675;41077;41112.794436027776;41179.382309265384;41226.793866030624;7359.632018399086;7521.285477879593;9251.213646840026;9387.342885997983;9440.386374885611;7439.851202975938;7514.2485751424965;7518.210587888248;7525.811854703621;10959.616413425532;11186.776264474705;11204.047655949254;11223.158263130257;11235.26970746903;11237.325760454358;11122.110231181527;11123.332600044023;11177.49701263441;11181.72045698856;11196.720081997933;10843.403612801292;10885.83671244932;10891.292066015683;10905.945470272678;10932.836007459895;38016.42975355372;38187;38240.42639360412;38290.61709382899;38290.80854595737;3801.5226045917757;3849.749766265184;3868.574456809749;3903.180332130256;3927.9214415711813;27468.450630987467;28743.85628071846;29017.274568135967;29352.38561879096;29470.705292947012;3033.7876348655604;3089.1041597936573;3096.6593674695764;3104.7050530199595;3110.3468271662978;361365;365017;366362;366396;368756;52984;53045.73477132589;53061.734691326295;53084.469155307954;53160.468395315555;55412;55434.61413464615;55440.16839747407;55465.168022479695;55481.72259138679;14823.332950017275;14907.956443048883;14924.552263432115;14931.029483083783;14935;12755.362231888368;12761.553345632858;12765;12775.872241277468;12785.424655890507;10883.619073332395;11094;11121.443927803577;11873.584424545272;12484.563040293546;4838.371011768448;4870.902581948412;4951.282064100686;5726.942730572724;5847.3275573308765;986.358866736627;1113.1929351220301;1148.8736239013701;1154.1632316570588;1164.2025212729138;26480.337991550365;26924.461510769674;27953;28557;29304.267393314913;1066.0938202527789;1071.121680222226;1097.6377795327523;1104.9502772375263;1118.1166878166157;13480;13637.454501820015;14351.282435878373;14736.189509577076;14755.55733328002;481066;483741;483878;484171;484822;39705;48467;48596.51403485991;48642.27036594454;48690.75654621704;1420.5525259543417;1453.6365908522869;1455.52695374006;1455.5924341184486;1456.4465503108752;20529.17883284652;22128.225512106997;25542.616860746733;26996.055138070074;27559.31101722473;39968.60031399765;40057.79971100126;40122.79938600288;40140.79577612676;40203.79898100491;434865;438276;439133;439219;441296;28643.67976617441;28848.84604615792;28951.276218094717;28959.85520072386;29014.839406423507;31070;31940.84029579837;32972.835135825124;39231.80384098061;39893.40159897662;29094.00466961655;29288.619705423695;32554;33740;33952.320953581286;26179.73820261773;30259.243518912204;33385.998420047436;33466.99599012033;33597.49603755995;32435.02694919156;33004.50493242555;33096.834515827264;33166.66833331732;33179.17052073621;27070.458590828468;29910.551341729457;30071.94748183803;31068.533971989986;31186.376272474878;21920.794356310555;22088.33734987953;22661.660075098556;23285.88357058204;23382.298531044096 09:13:03 INFO - PROCESS | 1648 | |2;jquery.html;383.26795819983835;385.2506874129815;403.15337790639643;421.09464651000343;449.70094886900193;12170.81743773843;20047.298344557945;20750.89624551875;21256.89371553142;21806.345809625698;23501;23956.76043239567;24772.876135619295;24872.62691059631;25184.740762961872;6732.899006514906;6955.860882782341;7771.572563509005;8121.837563248731;8317.251447369736;7646.655900484464;8008.63961121748;8233.300169485601;8296.502209867396;8335.083140854531;8059;8134.593270336489;8140.877886831702;8161.183881611821;8172.959135204315;7783.104942931579;8084.878726819103;8098.797530061736;8105.635246413866;8108.310793582553;7571.205023472567;7836.373090152774;7940.960295198544;7941.00737407824;7941.722039728582;29027.564586531218;30110.54834177489;30239.546406803915;30263.69736302631;30662.38675226483;2948.2187220386613;2968.5398763191524;2971.4651362754694;2972.2569357660586;3021.9244518886985;16964.0669763163;17816.91091544547;17895;18058.916465012142;18459.907700461412;2044.8261897738562;2106.7155933948875;2113.3871177358546;2115.344243284587;2131.818795402393;173059;177100.11449942796;182331;182589;182963;18430.907845460686;19143.904280478786;25177.62233566498;25683.10109146171;26173.083942061938;43254.783726081165;43281;43988.78005610016;44201.33697994533;44379.55620443819;11464.656060318204;11502.712432189262;11622.535098595961;11642.592509262135;11797.876382251106;9144.222741066951;9147.222486088756;9204.907950920538;9317;9368.063193680577;11537.826932596017;11643.88356116445;11646.95177434035;11657.591984280509;11795.646130616095;3954.3475326570792;4072.3077076897;4581.381513495702;4590.472095708969;4627.699199552018;883.6023789294715;1028.984565231522;1058.9046985771317;1075.6500591757294;1113.565709373345;16247;20325.898370508054;20990.685139722915;21944.780552194592;22140.114395424003;926.5413620258015;983.6065573770549;1066.4774260612244;1091.5742860284495;1102.2945314998408;8757.343199260082;10815.945920270347;11274.661760147208;12241.20432171906;12576.937115314548;786801;797127;803875;811391;814887;170011;170132.14933925497;172211;172641;179005.41989160143;1270.6505710929569;1293.1012946002438;1329.1891945912985;1332.3538084029237;1333.0735139078442;18392.540186495444;19382.4185274442;19642.705359419335;19922.30271940475;19942.90314032742;68465.31534684589;68808.6559567199;68854.96717549341;69520;71184.93222601562;88360.11639883519;88544;96775.0322496766;96888;97826.5108674452;9990.050945160197;10470.581176752845;10547.841782373423;11481.712957176138;11585.304881707125;11409.142049244852;12943.5469758558;13093.214407135602;13140.80288795688;13253.801192982306;11278.379689117177;11421.361241000453;11579.536818527502;11600.013998809858;11640.592579259684;11110.555577776799;11382.715432114263;11394.088472922313;11645.068394528587;11701.88298117008;11012.50443730018;11471.082313415074;11568.074554035826;11851.881481185423;11859.52561897549;10512.842307365243;11542.307461552333;11774.470148843151;11802.94098529502;11832.17174797756;10582.576696932036;11372.147088968195;11536.307821530734;11779.352135632622;11828.881711182778 09:13:03 INFO - PROCESS | 1648 | |3;mootools.html;1576.377330954273;1585.3183131253556;1602.9679406411879;1617.789687340645;1619.5465269724477;10916.945415272923;11546.134039947006;11569.53721851125;11571.247868888537;11576.363300018496;10751.731206719836;11135.944320278388;11315.038221751161;11315.490802913868;11385.886141138586;2198.3185212584112;2241.991104003197;2246.618074927258;2249.336445748508;2255.977440225601;2242.8990695418747;2269.8297627677907;2277.350954977832;2287.3824067501846;2288.8855557222155;2238.9888050559725;2249.910003599854;2268.852524585905;2272.9658005607494;2275.0331109278573;2207.0289072808073;2220.9222677206303;2229.27548546723;2230.241717815934;2236.0385034435267;2316.328264803205;2414.5653782319177;2414.5895197816412;2415.6618073469726;2417.903283868643;11141.944290278496;11210.215284930058;11226.438678066064;11234.382108984002;11245.943770281177;5822.417758224186;5996.070609055603;5997.460228579449;6000.96999515004;6002.249718785152;3366.4445366514497;3482.89551313461;3679.963200367989;3684.889453316405;3692.7968961707097;1164.1676201515872;1179.6696924861053;1215.1797536662805;1227.3372378915376;1253.6803115205564;13847.376868040963;14184.574462766133;14467.71064578713;15554.066755994676;15606;4615.284630882219;4738.905221895612;4793.760311984387;4806;4817.421909370898;11958.701032474257;11963.46164422603;11965.940170299093;11986.400679966142;12004.639860804189;4840.661153719277;5020.221865610836;5058.620603454756;5492.862678433071;5848.2689663792025;4645.3032045193495;4646.767661616906;4648.767561621906;4649.070185962821;4654.464736555272;3711.981440092782;3864.7294689371474;3947.6052394760295;3955.980220098881;3957.7229593928723;896.7264984179888;1031.118393773328;1035.3839465518004;1037.190991027;1049.5486940615608;895.9776005599782;919.6183583812643;928.7028150991753;943.9952800236092;974.541965276319;6437.678116094176;6439.130717353191;6477.870442591122;6618.238902526175;6713.865722685617;960.644561512245;984.606157536991;996.4668902137466;998.3710262534556;1002.9498525073863;4009.839606415769;4029.2545879012478;4081.10215752534;4088.693347998912;4188.28799104153;14117.858821411859;14530.346134423977;14538.709225815424;14540.49108281205;14546.272686365639;13017.958563314913;13490.258035808125;13841.515546955809;13864.890808735277;14381.712365752626;10173;10460.68617941463;10495.10791582724;10505.9474702626;10515.789684206273;6174.351693072163;6477.611343319416;6612.735490580515;6686.933130668631;6725.159355080615;10928.961748633867;11985.28088314704;12016.377788998374;12150.57472988441;12272.44773985155;12079.214851034654;12362.320072395745;12519.93740031294;12575.748485030064;12647.367631618567;9294.6282148716;9320.114589114024;9389.201917837061;9489.66786162481;9531.666391676257;10201.693949181536;10312.432816194882;10425.739356516147;10438.478076096317;10456.477176141314;8256.463329883538;9190.724278271662;9219.354645174773;9288.58201380926;9385.436873787594;8763.737087887373;8802.075051677359;8939.195472407515;9041.81916361656;9199.954000229956;7546.509476883985;7705.80735481595;7811.765647030598;7824.92175078242;7878.290953814184;5622.718864056863;5721.685307308138;5762.654240745569;5858.677772722371;5940.445608388434;5691.3170419549915;5884.264466941632;5887.735051922588;6000.21997140369;6227.065940108839 09:13:03 INFO - PROCESS | 1648 | |4;prototype.html;369.4790345612686;377.90741268389246;380.2717795421768;387.61238761238764;387.66854339539685;4999.400071991357;5019.4980501949785;5020.393474088293;5044.495550444954;5060.671056381338;4569.405977222957;4749.843886599226;4891.217405215166;4903.558679718824;4993.900121997558;3351.8324083795833;3426.847300483561;3765.887023389289;3813.9809300953457;3964.264657386394;3365.3942290387845;3558.537390139278;3930.626590473915;3957.683385329181;3971.6028397160344;3646.5624125105023;3819.9495138836905;3948.900113410973;3980.800959952005;3985.1431942132435;3225.5322978168033;3977.752569798069;4024.3359845625437;4120.546739858613;4190.497140343178;3468.1849765305133;3581;3838.692904567628;3855.4987851579394;3879.941800872989;4844.442889067732;4868.05073010763;4890.24201248807;4891.315215869781;4893.853184404438;4210.59999300066;4466.665000124971;4698.036902434993;4830.855074347775;4839.854804355875;5348.732563371816;5353.544948679367;5389.434109418533;5390.676559406448;5399.892002159974;3885.3589157789215;4291.635211007068;4356.671215279339;4368.536540259017;4376.118269144266;4855.17930775959;5353.57171426285;5359.651622644516;5487.201527221106;5737.876985515344;4137.668986481074;4173.269677806372;4348.412964249786;4354.956450435455;4390.363397307437;4465.682623626039;4474.955250447519;4481.305397663367;4560.475545312332;4565.178267911741;4001.959980400217;4802.471728109905;4834.6374021947795;4836.49354218196;4842.903141937141;4796.424429068534;5106.412762532282;5117.2068329409;5322.228276899906;5354.9196762048605;1373.8351397832125;1495.364470100203;1518.1043184520965;1528.6866192430525;1541.8590243219937;1036.8444733290066;1080.475969154959;1154.7575009247985;1160.2748282323548;1174.653477224221;4343.349527179715;4893.755312234445;4917.9426423319155;4922.655414121049;4940.258961155855;4685.461171965268;5102.979404119191;5224.582033437316;5524.14375771756;5551.139573366054;4204.3693445982735;4605.098787763687;4760.857174284777;4944.629152813553;4984.850454486371;2842.7299406556344;2864.8567571621334;2870.6555213374113;2879.8128121672025;2884.322184286691;5119.6416250862085;5354.351159526736;5701.971490142523;5732.111522713903;5937.228160339215;4807.6394270429855;5284.303303438234;5370.355557333145;5477.014137455217;5548.361938377057;5596.916046259309;5609.411011843779;5681.630694004876;5747.924860199773;5753.597248192586;4805.3512775774825;5484.040292948798;5557;5576.159867243881;5576.956706387837;4812.687175333592;5042.193249080129;5129.999650068201;5464.808731694372;5489.094299440548;4945.282933974626;5276.023935571931;5680.40355762639;5688.516476099578;5727.107810555643;3901.2587608355457;4156.854510092132;4415.842672489186;4468.508464069015;4476.888077797951;4710.351377018016;5305.946940530545;5545.445455454423;5568.610197286151;5588.357338905916;4396.450443694538;5196.298499702491;5204.947950520598;5343.919841202307;5572.721363931868;4717.150912835723;4867.318575399376;5369.865753356197;5377.919331209957;5396.595255355785;4353.825846966212;5026.824061157842;5188.22176673502;5276.973615132053;5279.894402112013;5338.4127745947135;5360.356757189163;5363.237932464705;5402.837914862561;5420.3440314244945;4645.442546894395;4989.004398240732;5251.186066159751;5304.443033481583;5331.546818520314 09:13:03 INFO - PROCESS | 1648 | |5;yui.html;742.6361083069294;755.0369040494714;758.1622307350374;826.223350050952;835.2190701693917;12517.937410312947;16432.67134657309;16435.342586296534;16436.83563164368;16480.587985300357;13520.918326533878;14040.64898377541;14391.568252952427;14903.329350179241;14943.028703134289;919.2462181011573;931.8136372725448;939.3893968920188;944.0842382888621;947.4741518457254;921.0191146429032;925.4354843545432;925.6667599664115;927.4249965021662;928.3826255540058;953.3183773601874;990.0990099009903;998.5606333213399;999.5052449037737;1001.7245257554158;988.6984469736727;989.8663680403125;991.2317953585956;992.4541502173812;992.7121134870879;732.2348146187247;733.8312188196692;733.966971486279;733.9980926035922;734.4271468254769;16115.677686446323;16302.429414970538;16327.591810204722;16462.75305870413;16594.917025414918;13976.790348144787;14188.645283867985;14336;14429.567112986628;14533.636659083502;11712.355820429873;11750.882491175063;11763.470643821049;11824.172307938448;11970.40147992597;3612.4942508048894;3664.633536646314;3719.3491139050557;3729.2914346274392;3742.0457783265365;97277.02722972751;117620;120367.3981630095;122247.3887630565;122466;10875.619353322596;10950.34297942126;11034.944825275983;11089.55641774336;11140;22877.428064298525;22902.885485572464;22951.196708115134;23184.3044708659;23328.300150995496;7344.596047217455;7543.73596924105;7577.848443031108;7645.082590089225;7680.846383072308;4225.302825033835;4383.189110014658;4393.494748104009;4426.247537918562;4479.507254202035;3554.20030493137;3666;3666.395044817575;3667.0832291927018;3675.338439080991;612.1063247658468;629.9874002520015;639.536336156283;646.2826262848234;651.9152510173647;671.2247354305784;697.400235797214;700.3755564951356;716.4769718105708;747.622450662412;9688.564014619358;10317.638882639221;10407.635732749317;10464.790704186025;10672.57309707603;646.3310473659834;657.8486948001986;685.7641904062518;693.4036728413561;697.769735987123;4993.350864387679;5024.001908226252;5026.84919452417;5035.194368900959;5038.244263360452;81460.77808832872;95046.09907801944;102730.48634756928;103888;109103;74145;93091.06908930959;93722.53138734262;94065;97423.51288243655;64926.67536662286;74686.13284668035;74990;82767.17232827716;82998.19012669055;9814.65648702292;10846.511906964364;10868.51091700891;10964.342139471657;11273.774524509628;45987.08025839397;46010.76994615005;46320.30519542277;46902.06195876132;47615.523844762494;61052.389476106444;61447.69276153591;63288.36711633009;63529.68235158979;63927.68036159789;11075.5569777208;12660.30368329714;12681.779616867421;12684.429200685807;12968.962483001525;12368.381580921097;14482.275886205858;14503;14821.703565928836;14826.77759833625;13034.394245406156;13159;13163.934180329037;13569.592912212649;13775.655608609864;13316.348195329087;13513.891804885128;13656.180629161885;13816.171029738249;14108.082974606617;12939.029572782267;12951.611451656465;13567.914566834826;13647.385867635781;13956.511522096678;10680.198985075995;10937.260088064542;11212.26209937461;11217.775644487228;11441.828372574251;10546.103581195684;10615.522301496605;11190.216684831983;11362.431878405881;11383.886161138282 09:13:03 INFO - PROCESS | 1648 | __end_tp_report 09:13:03 INFO - PROCESS | 1648 | __start_cc_report 09:13:03 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1656 09:13:03 INFO - PROCESS | 1648 | __end_cc_report 09:13:03 INFO - PROCESS | 1648 | __startTimestamp1489594383353__endTimestamp 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | ------- Summary: start ------- 09:13:03 INFO - PROCESS | 1648 | Number of tests: 6 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5905.55 Median:6135.51 stddev:668.85 (10.9%) stddev-sans-first:641.82 09:13:03 INFO - PROCESS | 1648 | Values: 3418.7 3420.7 3440.1 3446.3 3468.5 5962.4 5979.6 6011.3 6081.1 6099.5 5974.3 6051.7 6062.0 6068.7 6070.1 5373.6 5404.9 5406.1 5416.8 5513.5 5331.8 5344.7 5505.2 5510.2 5577.8 5346.7 5390.6 5417.0 5424.0 5428.5 5401.5 5411.0 5412.9 5416.3 5425.0 3890.7 5270.8 5368.1 5377.0 5385.6 6019.5 6023.6 6032.2 6034.1 6035.5 6228.6 6232.7 6239.6 6246.8 6252.0 5286.6 6266.9 6270.2 6295.0 6341.1 5010.5 6093.1 6101.1 6112.7 6130.6 6518.0 6520.1 6569.1 6572.5 6594.4 6121.8 6151.2 6210.8 6218.8 6223.0 6193.4 6236.6 6245.8 6252.6 6342.8 6280.3 6327.1 6329.8 6346.3 6350.8 6333.6 6339.6 6346.8 6349.1 6349.8 5000.0 5023.8 5088.9 5137.7 5207.5 4187.5 4533.1 4575.2 4597.0 4621.7 5038.8 6040.0 6106.3 6118.4 6134.4 6179.2 6242.5 6429.3 6451.9 6455.7 5964.8 6068.9 6097.5 6099.5 6106.1 5672.5 5673.9 5674.1 5674.7 5678.3 6613.6 6639.0 6663.0 6664.4 6678.5 6135.5 6212.4 6253.3 6257.2 6270.2 6444.1 6460.0 6463.5 6468.5 6485.4 6288.1 6317.4 6331.0 6353.2 6359.3 6378.1 6392.6 6396.3 6398.0 6410.1 6117.8 6252.9 6256.2 6263.7 6274.4 6158.9 6181.2 6222.0 6254.8 6267.9 6227.5 6255.5 6265.1 6269.7 6279.0 6239.1 6245.5 6249.3 6255.2 6273.8 6025.2 6098.9 6109.7 6126.2 6152.1 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:55886.71 Median:31563.61 stddev:114773.29 (363.6%) stddev-sans-first:115020.59 09:13:03 INFO - PROCESS | 1648 | Values: 743.5 767.6 811.9 862.4 881.5 27618.0 39293.0 39714.0 39815.0 39838.6 33176.5 41077.0 41112.8 41179.4 41226.8 7359.6 7521.3 9251.2 9387.3 9440.4 7439.9 7514.2 7518.2 7525.8 10959.6 11186.8 11204.0 11223.2 11235.3 11237.3 11122.1 11123.3 11177.5 11181.7 11196.7 10843.4 10885.8 10891.3 10905.9 10932.8 38016.4 38187.0 38240.4 38290.6 38290.8 3801.5 3849.7 3868.6 3903.2 3927.9 27468.5 28743.9 29017.3 29352.4 29470.7 3033.8 3089.1 3096.7 3104.7 3110.3 361365.0 365017.0 366362.0 366396.0 368756.0 52984.0 53045.7 53061.7 53084.5 53160.5 55412.0 55434.6 55440.2 55465.2 55481.7 14823.3 14908.0 14924.6 14931.0 14935.0 12755.4 12761.6 12765.0 12775.9 12785.4 10883.6 11094.0 11121.4 11873.6 12484.6 4838.4 4870.9 4951.3 5726.9 5847.3 986.4 1113.2 1148.9 1154.2 1164.2 26480.3 26924.5 27953.0 28557.0 29304.3 1066.1 1071.1 1097.6 1105.0 1118.1 13480.0 13637.5 14351.3 14736.2 14755.6 481066.0 483741.0 483878.0 484171.0 484822.0 39705.0 48467.0 48596.5 48642.3 48690.8 1420.6 1453.6 1455.5 1455.6 1456.4 20529.2 22128.2 25542.6 26996.1 27559.3 39968.6 40057.8 40122.8 40140.8 40203.8 434865.0 438276.0 439133.0 439219.0 441296.0 28643.7 28848.8 28951.3 28959.9 29014.8 31070.0 31940.8 32972.8 39231.8 39893.4 29094.0 29288.6 32554.0 33740.0 33952.3 26179.7 30259.2 33386.0 33467.0 33597.5 32435.0 33004.5 33096.8 33166.7 33179.2 27070.5 29910.6 30071.9 31068.5 31186.4 21920.8 22088.3 22661.7 23285.9 23382.3 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:47053.47 Median:2114.37 stddev:134527.33 (6362.5%) stddev-sans-first:134859.08 09:13:03 INFO - PROCESS | 1648 | Values: 383.3 385.3 403.2 421.1 449.7 12170.8 20047.3 20750.9 21256.9 21806.3 23501.0 23956.8 24772.9 24872.6 25184.7 6732.9 6955.9 7771.6 8121.8 8317.3 7646.7 8008.6 8233.3 8296.5 8335.1 8059.0 8134.6 8140.9 8161.2 8173.0 7783.1 8084.9 8098.8 8105.6 8108.3 7571.2 7836.4 7941.0 7941.0 7941.7 29027.6 30110.5 30239.5 30263.7 30662.4 2948.2 2968.5 2971.5 2972.3 3021.9 16964.1 17816.9 17895.0 18058.9 18459.9 2044.8 2106.7 2113.4 2115.3 2131.8 173059.0 177100.1 182331.0 182589.0 182963.0 18430.9 19143.9 25177.6 25683.1 26173.1 43254.8 43281.0 43988.8 44201.3 44379.6 11464.7 11502.7 11622.5 11642.6 11797.9 9144.2 9147.2 9204.9 9317.0 9368.1 11537.8 11643.9 11647.0 11657.6 11795.6 3954.3 4072.3 4581.4 4590.5 4627.7 883.6 1029.0 1058.9 1075.7 1113.6 16247.0 20325.9 20990.7 21944.8 22140.1 926.5 983.6 1066.5 1091.6 1102.3 8757.3 10815.9 11274.7 12241.2 12576.9 786801.0 797127.0 803875.0 811391.0 814887.0 170011.0 170132.1 172211.0 172641.0 179005.4 1270.7 1293.1 1329.2 1332.4 1333.1 18392.5 19382.4 19642.7 19922.3 19942.9 68465.3 68808.7 68855.0 69520.0 71184.9 88360.1 88544.0 96775.0 96888.0 97826.5 9990.1 10470.6 10547.8 11481.7 11585.3 11409.1 12943.5 13093.2 13140.8 13253.8 11278.4 11421.4 11579.5 11600.0 11640.6 11110.6 11382.7 11394.1 11645.1 11701.9 11012.5 11471.1 11568.1 11851.9 11859.5 10512.8 11542.3 11774.5 11802.9 11832.2 10582.6 11372.1 11536.3 11779.4 11828.9 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:6752.32 Median:2365.45 stddev:4297.22 (181.7%) stddev-sans-first:4291.68 09:13:03 INFO - PROCESS | 1648 | Values: 1576.4 1585.3 1603.0 1617.8 1619.5 10916.9 11546.1 11569.5 11571.2 11576.4 10751.7 11135.9 11315.0 11315.5 11385.9 2198.3 2242.0 2246.6 2249.3 2256.0 2242.9 2269.8 2277.4 2287.4 2288.9 2239.0 2249.9 2268.9 2273.0 2275.0 2207.0 2220.9 2229.3 2230.2 2236.0 2316.3 2414.6 2414.6 2415.7 2417.9 11141.9 11210.2 11226.4 11234.4 11245.9 5822.4 5996.1 5997.5 6001.0 6002.2 3366.4 3482.9 3680.0 3684.9 3692.8 1164.2 1179.7 1215.2 1227.3 1253.7 13847.4 14184.6 14467.7 15554.1 15606.0 4615.3 4738.9 4793.8 4806.0 4817.4 11958.7 11963.5 11965.9 11986.4 12004.6 4840.7 5020.2 5058.6 5492.9 5848.3 4645.3 4646.8 4648.8 4649.1 4654.5 3712.0 3864.7 3947.6 3956.0 3957.7 896.7 1031.1 1035.4 1037.2 1049.5 896.0 919.6 928.7 944.0 974.5 6437.7 6439.1 6477.9 6618.2 6713.9 960.6 984.6 996.5 998.4 1002.9 4009.8 4029.3 4081.1 4088.7 4188.3 14117.9 14530.3 14538.7 14540.5 14546.3 13018.0 13490.3 13841.5 13864.9 14381.7 10173.0 10460.7 10495.1 10505.9 10515.8 6174.4 6477.6 6612.7 6686.9 6725.2 10929.0 11985.3 12016.4 12150.6 12272.4 12079.2 12362.3 12519.9 12575.7 12647.4 9294.6 9320.1 9389.2 9489.7 9531.7 10201.7 10312.4 10425.7 10438.5 10456.5 8256.5 9190.7 9219.4 9288.6 9385.4 8763.7 8802.1 8939.2 9041.8 9200.0 7546.5 7705.8 7811.8 7824.9 7878.3 5622.7 5721.7 5762.7 5858.7 5940.4 5691.3 5884.3 5887.7 6000.2 6227.1 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4457.04 Median:4843.67 stddev:1252.04 (25.8%) stddev-sans-first:1217.38 09:13:03 INFO - PROCESS | 1648 | Values: 369.5 377.9 380.3 387.6 387.7 4999.4 5019.5 5020.4 5044.5 5060.7 4569.4 4749.8 4891.2 4903.6 4993.9 3351.8 3426.8 3765.9 3814.0 3964.3 3365.4 3558.5 3930.6 3957.7 3971.6 3646.6 3819.9 3948.9 3980.8 3985.1 3225.5 3977.8 4024.3 4120.5 4190.5 3468.2 3581.0 3838.7 3855.5 3879.9 4844.4 4868.1 4890.2 4891.3 4893.9 4210.6 4466.7 4698.0 4830.9 4839.9 5348.7 5353.5 5389.4 5390.7 5399.9 3885.4 4291.6 4356.7 4368.5 4376.1 4855.2 5353.6 5359.7 5487.2 5737.9 4137.7 4173.3 4348.4 4355.0 4390.4 4465.7 4475.0 4481.3 4560.5 4565.2 4002.0 4802.5 4834.6 4836.5 4842.9 4796.4 5106.4 5117.2 5322.2 5354.9 1373.8 1495.4 1518.1 1528.7 1541.9 1036.8 1080.5 1154.8 1160.3 1174.7 4343.3 4893.8 4917.9 4922.7 4940.3 4685.5 5103.0 5224.6 5524.1 5551.1 4204.4 4605.1 4760.9 4944.6 4984.9 2842.7 2864.9 2870.7 2879.8 2884.3 5119.6 5354.4 5702.0 5732.1 5937.2 4807.6 5284.3 5370.4 5477.0 5548.4 5596.9 5609.4 5681.6 5747.9 5753.6 4805.4 5484.0 5557.0 5576.2 5577.0 4812.7 5042.2 5130.0 5464.8 5489.1 4945.3 5276.0 5680.4 5688.5 5727.1 3901.3 4156.9 4415.8 4468.5 4476.9 4710.4 5305.9 5545.4 5568.6 5588.4 4396.5 5196.3 5204.9 5343.9 5572.7 4717.2 4867.3 5369.9 5377.9 5396.6 4353.8 5026.8 5188.2 5277.0 5279.9 5338.4 5360.4 5363.2 5402.8 5420.3 4645.4 4989.0 5251.2 5304.4 5331.5 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20518.82 Median:3666.74 stddev:29700.09 (810.0%) stddev-sans-first:29746.28 09:13:03 INFO - PROCESS | 1648 | Values: 742.6 755.0 758.2 826.2 835.2 12517.9 16432.7 16435.3 16436.8 16480.6 13520.9 14040.6 14391.6 14903.3 14943.0 919.2 931.8 939.4 944.1 947.5 921.0 925.4 925.7 927.4 928.4 953.3 990.1 998.6 999.5 1001.7 988.7 989.9 991.2 992.5 992.7 732.2 733.8 734.0 734.0 734.4 16115.7 16302.4 16327.6 16462.8 16594.9 13976.8 14188.6 14336.0 14429.6 14533.6 11712.4 11750.9 11763.5 11824.2 11970.4 3612.5 3664.6 3719.3 3729.3 3742.0 97277.0 117620.0 120367.4 122247.4 122466.0 10875.6 10950.3 11034.9 11089.6 11140.0 22877.4 22902.9 22951.2 23184.3 23328.3 7344.6 7543.7 7577.8 7645.1 7680.8 4225.3 4383.2 4393.5 4426.2 4479.5 3554.2 3666.0 3666.4 3667.1 3675.3 612.1 630.0 639.5 646.3 651.9 671.2 697.4 700.4 716.5 747.6 9688.6 10317.6 10407.6 10464.8 10672.6 646.3 657.8 685.8 693.4 697.8 4993.4 5024.0 5026.8 5035.2 5038.2 81460.8 95046.1 102730.5 103888.0 109103.0 74145.0 93091.1 93722.5 94065.0 97423.5 64926.7 74686.1 74990.0 82767.2 82998.2 9814.7 10846.5 10868.5 10964.3 11273.8 45987.1 46010.8 46320.3 46902.1 47615.5 61052.4 61447.7 63288.4 63529.7 63927.7 11075.6 12660.3 12681.8 12684.4 12969.0 12368.4 14482.3 14503.0 14821.7 14826.8 13034.4 13159.0 13163.9 13569.6 13775.7 13316.3 13513.9 13656.2 13816.2 14108.1 12939.0 12951.6 13567.9 13647.4 13956.5 10680.2 10937.3 11212.3 11217.8 11441.8 10546.1 10615.5 11190.2 11362.4 11383.9 09:13:03 INFO - PROCESS | 1648 | -------- Summary: end -------- 09:13:03 INFO - PROCESS | 1648 | 09:13:03 INFO - TEST-INFO | 1648: exit 0 09:13:04 INFO - TEST-OK | dromaeo_css | took 1120729ms 09:13:04 INFO - TEST-START | kraken 09:13:04 INFO - operating with platform_type : mac_ 09:13:04 INFO - Initialising browser for kraken test... 09:13:04 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp38OLlZ/profile http://localhost:49250/getInfo.html) 09:13:06 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 09:13:06 INFO - PROCESS | 1654 | colorDepth:24 09:13:06 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 09:13:06 INFO - PROCESS | 1654 | __metrics 09:13:06 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:13:06 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:13:07 INFO - TEST-INFO | 1654: exit 0 09:13:07 INFO - Browser initialized. 09:13:07 INFO - Running cycle 1/1 for kraken test... 09:13:07 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/tmp38OLlZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:19 INFO - PROCESS | 1655 | RSS: Main: 215597056 09:13:19 INFO - PROCESS | 1655 | 09:13:22 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:23 INFO - PROCESS | 1655 | RSS: Main: 267739136 09:13:23 INFO - PROCESS | 1655 | 09:13:25 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 09:13:26 INFO - PROCESS | 1655 | RSS: Main: 278310912 09:13:26 INFO - PROCESS | 1655 | 09:13:29 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 09:13:30 INFO - PROCESS | 1655 | RSS: Main: 375160832 09:13:30 INFO - PROCESS | 1655 | 09:13:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 09:13:32 INFO - PROCESS | 1655 | RSS: Main: 279072768 09:13:32 INFO - PROCESS | 1655 | 09:13:34 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:35 INFO - PROCESS | 1655 | RSS: Main: 280576000 09:13:35 INFO - PROCESS | 1655 | 09:13:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:39 INFO - PROCESS | 1655 | RSS: Main: 321351680 09:13:39 INFO - PROCESS | 1655 | 09:13:42 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:42 INFO - PROCESS | 1655 | RSS: Main: 321716224 09:13:42 INFO - PROCESS | 1655 | 09:13:45 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 09:13:46 INFO - PROCESS | 1655 | RSS: Main: 317476864 09:13:46 INFO - PROCESS | 1655 | 09:13:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:48 INFO - PROCESS | 1655 | RSS: Main: 296161280 09:13:48 INFO - PROCESS | 1655 | 09:13:50 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:50 INFO - PROCESS | 1655 | RSS: Main: 298098688 09:13:50 INFO - PROCESS | 1655 | 09:13:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:53 INFO - PROCESS | 1655 | RSS: Main: 306200576 09:13:53 INFO - PROCESS | 1655 | 09:13:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:57 INFO - PROCESS | 1655 | RSS: Main: 310370304 09:13:57 INFO - PROCESS | 1655 | 09:14:00 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:14:01 INFO - PROCESS | 1655 | RSS: Main: 311009280 09:14:01 INFO - PROCESS | 1655 | 09:14:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 09:14:03 INFO - PROCESS | 1655 | RSS: Main: 355676160 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | __start_tp_report 09:14:03 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 09:14:03 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 09:14:03 INFO - PROCESS | 1655 | |i|pagename|runs| 09:14:03 INFO - PROCESS | 1655 | |0;ai-astar;116;160;172;134;116;114;114;114;114;115 09:14:03 INFO - PROCESS | 1655 | |1;audio-beat-detection;132;110;108;143;109;107;105;109;128;107 09:14:03 INFO - PROCESS | 1655 | |2;audio-dft;183;180;187;185;182;183;183;182;185;184 09:14:03 INFO - PROCESS | 1655 | |3;audio-fft;83;59;61;92;62;61;58;62;77;60 09:14:03 INFO - PROCESS | 1655 | |4;audio-oscillator;87;69;87;70;69;68;82;70;69;86 09:14:03 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;90;89;88;88;89;88;88;88;88;88 09:14:03 INFO - PROCESS | 1655 | |6;imaging-darkroom;95;96;96;99;96;108;115;98;96;96 09:14:03 INFO - PROCESS | 1655 | |7;imaging-desaturate;83;85;86;86;84;85;86;82;82;86 09:14:03 INFO - PROCESS | 1655 | |8;json-parse-financial;64;61;61;60;62;63;65;64;64;65 09:14:03 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;53;60;64;62;60;56;56;56;57;57 09:14:03 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;84;86;87;84;86;85;88;89;110;85 09:14:03 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;138;145;151;138;139;138;160;144;163;135 09:14:03 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;166;161;164;167;165;165;166;164;162;163 09:14:03 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;68;65;64;64;73;81;80;82;68;64 09:14:03 INFO - PROCESS | 1655 | __end_tp_report 09:14:03 INFO - PROCESS | 1655 | __start_cc_report 09:14:03 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2125 09:14:03 INFO - PROCESS | 1655 | __end_cc_report 09:14:03 INFO - PROCESS | 1655 | __startTimestamp1489594443125__endTimestamp 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | ------- Summary: start ------- 09:14:03 INFO - PROCESS | 1655 | Number of tests: 14 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:126.90 Median:116.00 stddev:21.67 (18.7%) stddev-sans-first:22.62 09:14:03 INFO - PROCESS | 1655 | Values: 116.0 160.0 172.0 134.0 116.0 114.0 114.0 114.0 114.0 115.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:115.80 Median:109.50 stddev:13.37 (12.2%) stddev-sans-first:12.84 09:14:03 INFO - PROCESS | 1655 | Values: 132.0 110.0 108.0 143.0 109.0 107.0 105.0 109.0 128.0 107.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:183.40 Median:183.50 stddev:1.96 (1.1%) stddev-sans-first:2.07 09:14:03 INFO - PROCESS | 1655 | Values: 183.0 180.0 187.0 185.0 182.0 183.0 183.0 182.0 185.0 184.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:67.50 Median:62.00 stddev:11.99 (19.3%) stddev-sans-first:11.33 09:14:03 INFO - PROCESS | 1655 | Values: 83.0 59.0 61.0 92.0 62.0 61.0 58.0 62.0 77.0 60.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.00 stddev:8.56 (11.3%) stddev-sans-first:8.05 09:14:03 INFO - PROCESS | 1655 | Values: 87.0 69.0 87.0 70.0 69.0 68.0 82.0 70.0 69.0 86.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:88.00 stddev:0.70 (0.8%) stddev-sans-first:0.44 09:14:03 INFO - PROCESS | 1655 | Values: 90.0 89.0 88.0 88.0 89.0 88.0 88.0 88.0 88.0 88.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:96.00 stddev:6.64 (6.9%) stddev-sans-first:6.84 09:14:03 INFO - PROCESS | 1655 | Values: 95.0 96.0 96.0 99.0 96.0 108.0 115.0 98.0 96.0 96.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.50 stddev:1.65 (1.9%) stddev-sans-first:1.66 09:14:03 INFO - PROCESS | 1655 | Values: 83.0 85.0 86.0 86.0 84.0 85.0 86.0 82.0 82.0 86.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:64.00 stddev:1.79 (2.8%) stddev-sans-first:1.86 09:14:03 INFO - PROCESS | 1655 | Values: 64.0 61.0 61.0 60.0 62.0 63.0 65.0 64.0 64.0 65.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.50 stddev:3.31 (5.7%) stddev-sans-first:2.96 09:14:03 INFO - PROCESS | 1655 | Values: 53.0 60.0 64.0 62.0 60.0 56.0 56.0 56.0 57.0 57.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:86.00 stddev:7.76 (9.0%) stddev-sans-first:8.07 09:14:03 INFO - PROCESS | 1655 | Values: 84.0 86.0 87.0 84.0 86.0 85.0 88.0 89.0 110.0 85.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:145.10 Median:144.50 stddev:9.83 (6.8%) stddev-sans-first:10.08 09:14:03 INFO - PROCESS | 1655 | Values: 138.0 145.0 151.0 138.0 139.0 138.0 160.0 144.0 163.0 135.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.30 Median:165.00 stddev:1.89 (1.1%) stddev-sans-first:1.90 09:14:03 INFO - PROCESS | 1655 | Values: 166.0 161.0 164.0 167.0 165.0 165.0 166.0 164.0 162.0 163.0 09:14:03 INFO - PROCESS | 1655 | 09:14:03 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:70.50 stddev:7.50 (10.6%) stddev-sans-first:7.89 09:14:03 INFO - PROCESS | 1655 | Values: 68.0 65.0 64.0 64.0 73.0 81.0 80.0 82.0 68.0 64.0 09:14:03 INFO - PROCESS | 1655 | -------- Summary: end -------- 09:14:03 INFO - PROCESS | 1655 | 09:14:04 INFO - TEST-INFO | 1655: exit 0 09:14:04 INFO - TEST-OK | kraken | took 60066ms 09:14:04 INFO - SUITE-END | took 1180s 09:14:04 INFO - Completed test suite (00:19:41) 09:14:04 INFO - javascript benchmark 09:14:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7740.652808682248, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3418.675225853543, 3420.692137707606, 3440.071180781189, 3446.3279660466205, 3468.4797280407934, 5962.403759624035, 5979.63551462481, 6011.308699499548, 6081.0878368244785, 6099.5120390368775, 5974.31295401029, 6051.7276722547485, 6061.9696901515545, 6068.726907289171, 6070.089486577016, 5373.623846330749, 5404.864878378053, 5406.053940560406, 5416.783328666848, 5513.531349835269, 5331.760070796823, 5344.652597581165, 5505.229267902497, 5510.228568000483, 5577.776888924438, 5346.679199248058, 5390.6226564140525, 5417.024935511607, 5424.0, 5428.4842939920845, 5401.540869026137, 5410.972945135289, 5412.9458705413035, 5416.322959630046, 5425.0, 3890.747101438426, 5270.8155214567305, 5368.114261146906, 5377.0321342158395, 5385.5960802939935, 6019.458248757633, 6023.6385816851125, 6032.245969253843, 6034.064719968412, 6035.486983606399, 6228.5951413158, 6232.688365581748, 6239.625622462667, 6246.781362652331, 6251.9687401562705, 5286.550643195333, 6266.937330626681, 6270.247570291549, 6294.968525157391, 6341.143945567382, 5010.4739002404585, 6093.11649810775, 6101.0848372744, 6112.7249273782345, 6130.570860039799, 6517.9674101630135, 6520.11978382917, 6569.146011018537, 6572.474202063823, 6594.439472644831, 6121.755129794848, 6151.200343955346, 6210.844728881723, 6218.782342617987, 6223.0, 6193.380661933861, 6236.6258024518675, 6245.750169993149, 6252.562320637603, 6342.778002769973, 6280.309165991737, 6327.145835312266, 6329.778457754049, 6346.30190679025, 6350.8412289692205, 6333.588316759488, 6339.587926784837, 6346.777862774781, 6349.142865713162, 6349.777757778455, 5000.0, 5023.824166154167, 5088.949110508847, 5137.717425541557, 5207.479252074762, 4187.45563076798, 4533.116042371706, 4575.199340115533, 4596.954030459719, 4621.653375996813, 5038.84883453497, 6039.969800150971, 6106.297775755845, 6118.357572454917, 6134.44789968896, 6179.227596550431, 6242.469390101802, 6429.292777794439, 6451.870962580722, 6455.741770329134, 5964.7912323068485, 6068.937935861207, 6097.512199024068, 6099.451049405486, 6106.145139680449, 5672.517835983987, 5673.858153546112, 5674.092145256739, 5674.744636491368, 5678.261825962599, 6613.603183808795, 6638.966805165944, 6663.0, 6664.366885145903, 6678.53250272486, 6135.5082808396355, 6212.409821066992, 6253.312135664983, 6257.186565746424, 6270.153529273673, 6444.065610486359, 6460.0, 6463.450606698483, 6468.482521398183, 6485.416312531895, 6288.056791481132, 6317.399847014526, 6330.968345158245, 6353.237611486651, 6359.332270111757, 6378.138951241523, 6392.64840433762, 6396.264429590657, 6398.0, 6410.134631824644, 6117.796956032775, 6252.906206406817, 6256.155419018374, 6263.686815659108, 6274.435300822948, 6158.876822463615, 6181.196444462191, 6222.0, 6254.781082662085, 6267.905981410191, 6227.470664993526, 6255.499560035095, 6265.060240963892, 6269.717862696099, 6279.0, 6239.06414037898, 6245.500359971283, 6249.34381889895, 6255.218097737783, 6273.780417685359, 6025.216721826135, 6098.871708733898, 6109.7387008107025, 6126.151269885628, 6152.077188421773], "value": 5863.066571789144, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.4758495260842, 767.6353731977312, 811.8701007838747, 862.3704695572233, 881.4799268431632, 27618.0, 39293.01767455815, 39714.0, 39814.99999999996, 39838.60161398393, 33176.502352464675, 41077.0, 41112.794436027776, 41179.382309265384, 41226.793866030624, 7359.632018399086, 7521.285477879593, 9251.213646840026, 9387.342885997983, 9440.386374885611, 7439.851202975938, 7514.2485751424965, 7518.210587888248, 7525.811854703621, 10959.616413425532, 11186.776264474705, 11204.047655949254, 11223.158263130257, 11235.26970746903, 11237.325760454358, 11122.110231181527, 11123.332600044023, 11177.49701263441, 11181.72045698856, 11196.720081997933, 10843.403612801292, 10885.83671244932, 10891.292066015683, 10905.945470272678, 10932.836007459895, 38016.42975355372, 38187.0, 38240.42639360412, 38290.61709382899, 38290.80854595737, 3801.5226045917757, 3849.749766265184, 3868.574456809749, 3903.180332130256, 3927.9214415711813, 27468.450630987467, 28743.85628071846, 29017.274568135967, 29352.38561879096, 29470.705292947012, 3033.7876348655604, 3089.1041597936573, 3096.6593674695764, 3104.7050530199595, 3110.3468271662978, 361365.0, 365017.0, 366362.0, 366396.0, 368756.0, 52984.0, 53045.73477132589, 53061.734691326295, 53084.469155307954, 53160.468395315555, 55412.0, 55434.61413464615, 55440.16839747407, 55465.168022479695, 55481.72259138679, 14823.332950017275, 14907.956443048883, 14924.552263432115, 14931.029483083783, 14935.0, 12755.362231888368, 12761.553345632858, 12765.0, 12775.872241277468, 12785.424655890507, 10883.619073332395, 11094.0, 11121.443927803577, 11873.584424545272, 12484.563040293546, 4838.371011768448, 4870.902581948412, 4951.282064100686, 5726.942730572724, 5847.3275573308765, 986.358866736627, 1113.1929351220301, 1148.8736239013701, 1154.1632316570588, 1164.2025212729138, 26480.337991550365, 26924.461510769674, 27953.0, 28557.0, 29304.267393314913, 1066.0938202527789, 1071.121680222226, 1097.6377795327523, 1104.9502772375263, 1118.1166878166157, 13480.0, 13637.454501820015, 14351.282435878373, 14736.189509577076, 14755.55733328002, 481066.0, 483741.0, 483878.0, 484171.0, 484822.0, 39705.0, 48467.0, 48596.51403485991, 48642.27036594454, 48690.75654621704, 1420.5525259543417, 1453.6365908522869, 1455.52695374006, 1455.5924341184486, 1456.4465503108752, 20529.17883284652, 22128.225512106997, 25542.616860746733, 26996.055138070074, 27559.31101722473, 39968.60031399765, 40057.79971100126, 40122.79938600288, 40140.79577612676, 40203.79898100491, 434865.0, 438276.0, 439133.0, 439219.0, 441296.0, 28643.67976617441, 28848.84604615792, 28951.276218094717, 28959.85520072386, 29014.839406423507, 31070.0, 31940.84029579837, 32972.835135825124, 39231.80384098061, 39893.40159897662, 29094.00466961655, 29288.619705423695, 32554.0, 33740.0, 33952.320953581286, 26179.73820261773, 30259.243518912204, 33385.998420047436, 33466.99599012033, 33597.49603755995, 32435.02694919156, 33004.50493242555, 33096.834515827264, 33166.66833331732, 33179.17052073621, 27070.458590828468, 29910.551341729457, 30071.94748183803, 31068.533971989986, 31186.376272474878, 21920.794356310555, 22088.33734987953, 22661.660075098556, 23285.88357058204, 23382.298531044096], "value": 18310.27967449922, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.26795819983835, 385.2506874129815, 403.15337790639643, 421.09464651000343, 449.70094886900193, 12170.81743773843, 20047.298344557945, 20750.89624551875, 21256.89371553142, 21806.345809625698, 23501.0, 23956.76043239567, 24772.876135619295, 24872.62691059631, 25184.740762961872, 6732.899006514906, 6955.860882782341, 7771.572563509005, 8121.837563248731, 8317.251447369736, 7646.655900484464, 8008.63961121748, 8233.300169485601, 8296.502209867396, 8335.083140854531, 8059.0, 8134.593270336489, 8140.877886831702, 8161.183881611821, 8172.959135204315, 7783.104942931579, 8084.878726819103, 8098.797530061736, 8105.635246413866, 8108.310793582553, 7571.205023472567, 7836.373090152774, 7940.960295198544, 7941.00737407824, 7941.722039728582, 29027.564586531218, 30110.54834177489, 30239.546406803915, 30263.69736302631, 30662.38675226483, 2948.2187220386613, 2968.5398763191524, 2971.4651362754694, 2972.2569357660586, 3021.9244518886985, 16964.0669763163, 17816.91091544547, 17895.0, 18058.916465012142, 18459.907700461412, 2044.8261897738562, 2106.7155933948875, 2113.3871177358546, 2115.344243284587, 2131.818795402393, 173059.0, 177100.11449942796, 182331.0, 182589.0, 182963.0, 18430.907845460686, 19143.904280478786, 25177.62233566498, 25683.10109146171, 26173.083942061938, 43254.783726081165, 43281.0, 43988.78005610016, 44201.33697994533, 44379.55620443819, 11464.656060318204, 11502.712432189262, 11622.535098595961, 11642.592509262135, 11797.876382251106, 9144.222741066951, 9147.222486088756, 9204.907950920538, 9317.0, 9368.063193680577, 11537.826932596017, 11643.88356116445, 11646.95177434035, 11657.591984280509, 11795.646130616095, 3954.3475326570792, 4072.3077076897, 4581.381513495702, 4590.472095708969, 4627.699199552018, 883.6023789294715, 1028.984565231522, 1058.9046985771317, 1075.6500591757294, 1113.565709373345, 16247.0, 20325.898370508054, 20990.685139722915, 21944.780552194592, 22140.114395424003, 926.5413620258015, 983.6065573770549, 1066.4774260612244, 1091.5742860284495, 1102.2945314998408, 8757.343199260082, 10815.945920270347, 11274.661760147208, 12241.20432171906, 12576.937115314548, 786801.0, 797127.0, 803875.0, 811391.0, 814887.0, 170011.0, 170132.14933925497, 172211.0, 172641.0, 179005.41989160143, 1270.6505710929569, 1293.1012946002438, 1329.1891945912985, 1332.3538084029237, 1333.0735139078442, 18392.540186495444, 19382.4185274442, 19642.705359419335, 19922.30271940475, 19942.90314032742, 68465.31534684589, 68808.6559567199, 68854.96717549341, 69520.0, 71184.93222601562, 88360.11639883519, 88544.0, 96775.0322496766, 96888.0, 97826.5108674452, 9990.050945160197, 10470.581176752845, 10547.841782373423, 11481.712957176138, 11585.304881707125, 11409.142049244852, 12943.5469758558, 13093.214407135602, 13140.80288795688, 13253.801192982306, 11278.379689117177, 11421.361241000453, 11579.536818527502, 11600.013998809858, 11640.592579259684, 11110.555577776799, 11382.715432114263, 11394.088472922313, 11645.068394528587, 11701.88298117008, 11012.50443730018, 11471.082313415074, 11568.074554035826, 11851.881481185423, 11859.52561897549, 10512.842307365243, 11542.307461552333, 11774.470148843151, 11802.94098529502, 11832.17174797756, 10582.576696932036, 11372.147088968195, 11536.307821530734, 11779.352135632622, 11828.881711182778], "value": 12499.291284238274, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1576.377330954273, 1585.3183131253556, 1602.9679406411879, 1617.789687340645, 1619.5465269724477, 10916.945415272923, 11546.134039947006, 11569.53721851125, 11571.247868888537, 11576.363300018496, 10751.731206719836, 11135.944320278388, 11315.038221751161, 11315.490802913868, 11385.886141138586, 2198.3185212584112, 2241.991104003197, 2246.618074927258, 2249.336445748508, 2255.977440225601, 2242.8990695418747, 2269.8297627677907, 2277.350954977832, 2287.3824067501846, 2288.8855557222155, 2238.9888050559725, 2249.910003599854, 2268.852524585905, 2272.9658005607494, 2275.0331109278573, 2207.0289072808073, 2220.9222677206303, 2229.27548546723, 2230.241717815934, 2236.0385034435267, 2316.328264803205, 2414.5653782319177, 2414.5895197816412, 2415.6618073469726, 2417.903283868643, 11141.944290278496, 11210.215284930058, 11226.438678066064, 11234.382108984002, 11245.943770281177, 5822.417758224186, 5996.070609055603, 5997.460228579449, 6000.96999515004, 6002.249718785152, 3366.4445366514497, 3482.89551313461, 3679.963200367989, 3684.889453316405, 3692.7968961707097, 1164.1676201515872, 1179.6696924861053, 1215.1797536662805, 1227.3372378915376, 1253.6803115205564, 13847.376868040963, 14184.574462766133, 14467.71064578713, 15554.066755994676, 15606.0, 4615.284630882219, 4738.905221895612, 4793.760311984387, 4806.0, 4817.421909370898, 11958.701032474257, 11963.46164422603, 11965.940170299093, 11986.400679966142, 12004.639860804189, 4840.661153719277, 5020.221865610836, 5058.620603454756, 5492.862678433071, 5848.2689663792025, 4645.3032045193495, 4646.767661616906, 4648.767561621906, 4649.070185962821, 4654.464736555272, 3711.981440092782, 3864.7294689371474, 3947.6052394760295, 3955.980220098881, 3957.7229593928723, 896.7264984179888, 1031.118393773328, 1035.3839465518004, 1037.190991027, 1049.5486940615608, 895.9776005599782, 919.6183583812643, 928.7028150991753, 943.9952800236092, 974.541965276319, 6437.678116094176, 6439.130717353191, 6477.870442591122, 6618.238902526175, 6713.865722685617, 960.644561512245, 984.606157536991, 996.4668902137466, 998.3710262534556, 1002.9498525073863, 4009.839606415769, 4029.2545879012478, 4081.10215752534, 4088.693347998912, 4188.28799104153, 14117.858821411859, 14530.346134423977, 14538.709225815424, 14540.49108281205, 14546.272686365639, 13017.958563314913, 13490.258035808125, 13841.515546955809, 13864.890808735277, 14381.712365752626, 10173.0, 10460.68617941463, 10495.10791582724, 10505.9474702626, 10515.789684206273, 6174.351693072163, 6477.611343319416, 6612.735490580515, 6686.933130668631, 6725.159355080615, 10928.961748633867, 11985.28088314704, 12016.377788998374, 12150.57472988441, 12272.44773985155, 12079.214851034654, 12362.320072395745, 12519.93740031294, 12575.748485030064, 12647.367631618567, 9294.6282148716, 9320.114589114024, 9389.201917837061, 9489.66786162481, 9531.666391676257, 10201.693949181536, 10312.432816194882, 10425.739356516147, 10438.478076096317, 10456.477176141314, 8256.463329883538, 9190.724278271662, 9219.354645174773, 9288.58201380926, 9385.436873787594, 8763.737087887373, 8802.075051677359, 8939.195472407515, 9041.81916361656, 9199.954000229956, 7546.509476883985, 7705.80735481595, 7811.765647030598, 7824.92175078242, 7878.290953814184, 5622.718864056863, 5721.685307308138, 5762.654240745569, 5858.677772722371, 5940.445608388434, 5691.3170419549915, 5884.264466941632, 5887.735051922588, 6000.21997140369, 6227.065940108839], "value": 5102.758339038341, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.4790345612686, 377.90741268389246, 380.2717795421768, 387.61238761238764, 387.66854339539685, 4999.400071991357, 5019.4980501949785, 5020.393474088293, 5044.495550444954, 5060.671056381338, 4569.405977222957, 4749.843886599226, 4891.217405215166, 4903.558679718824, 4993.900121997558, 3351.8324083795833, 3426.847300483561, 3765.887023389289, 3813.9809300953457, 3964.264657386394, 3365.3942290387845, 3558.537390139278, 3930.626590473915, 3957.683385329181, 3971.6028397160344, 3646.5624125105023, 3819.9495138836905, 3948.900113410973, 3980.800959952005, 3985.1431942132435, 3225.5322978168033, 3977.752569798069, 4024.3359845625437, 4120.546739858613, 4190.497140343178, 3468.1849765305133, 3581.0, 3838.692904567628, 3855.4987851579394, 3879.941800872989, 4844.442889067732, 4868.05073010763, 4890.24201248807, 4891.315215869781, 4893.853184404438, 4210.59999300066, 4466.665000124971, 4698.036902434993, 4830.855074347775, 4839.854804355875, 5348.732563371816, 5353.544948679367, 5389.434109418533, 5390.676559406448, 5399.892002159974, 3885.3589157789215, 4291.635211007068, 4356.671215279339, 4368.536540259017, 4376.118269144266, 4855.17930775959, 5353.57171426285, 5359.651622644516, 5487.201527221106, 5737.876985515344, 4137.668986481074, 4173.269677806372, 4348.412964249786, 4354.956450435455, 4390.363397307437, 4465.682623626039, 4474.955250447519, 4481.305397663367, 4560.475545312332, 4565.178267911741, 4001.959980400217, 4802.471728109905, 4834.6374021947795, 4836.49354218196, 4842.903141937141, 4796.424429068534, 5106.412762532282, 5117.2068329409, 5322.228276899906, 5354.9196762048605, 1373.8351397832125, 1495.364470100203, 1518.1043184520965, 1528.6866192430525, 1541.8590243219937, 1036.8444733290066, 1080.475969154959, 1154.7575009247985, 1160.2748282323548, 1174.653477224221, 4343.349527179715, 4893.755312234445, 4917.9426423319155, 4922.655414121049, 4940.258961155855, 4685.461171965268, 5102.979404119191, 5224.582033437316, 5524.14375771756, 5551.139573366054, 4204.3693445982735, 4605.098787763687, 4760.857174284777, 4944.629152813553, 4984.850454486371, 2842.7299406556344, 2864.8567571621334, 2870.6555213374113, 2879.8128121672025, 2884.322184286691, 5119.6416250862085, 5354.351159526736, 5701.971490142523, 5732.111522713903, 5937.228160339215, 4807.6394270429855, 5284.303303438234, 5370.355557333145, 5477.014137455217, 5548.361938377057, 5596.916046259309, 5609.411011843779, 5681.630694004876, 5747.924860199773, 5753.597248192586, 4805.3512775774825, 5484.040292948798, 5557.0, 5576.159867243881, 5576.956706387837, 4812.687175333592, 5042.193249080129, 5129.999650068201, 5464.808731694372, 5489.094299440548, 4945.282933974626, 5276.023935571931, 5680.40355762639, 5688.516476099578, 5727.107810555643, 3901.2587608355457, 4156.854510092132, 4415.842672489186, 4468.508464069015, 4476.888077797951, 4710.351377018016, 5305.946940530545, 5545.445455454423, 5568.610197286151, 5588.357338905916, 4396.450443694538, 5196.298499702491, 5204.947950520598, 5343.919841202307, 5572.721363931868, 4717.150912835723, 4867.318575399376, 5369.865753356197, 5377.919331209957, 5396.595255355785, 4353.825846966212, 5026.824061157842, 5188.22176673502, 5276.973615132053, 5279.894402112013, 5338.4127745947135, 5360.356757189163, 5363.237932464705, 5402.837914862561, 5420.3440314244945, 4645.442546894395, 4989.004398240732, 5251.186066159751, 5304.443033481583, 5331.546818520314], "value": 4096.052599289623, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [742.6361083069294, 755.0369040494714, 758.1622307350374, 826.223350050952, 835.2190701693917, 12517.937410312947, 16432.67134657309, 16435.342586296534, 16436.83563164368, 16480.587985300357, 13520.918326533878, 14040.64898377541, 14391.568252952427, 14903.329350179241, 14943.028703134289, 919.2462181011573, 931.8136372725448, 939.3893968920188, 944.0842382888621, 947.4741518457254, 921.0191146429032, 925.4354843545432, 925.6667599664115, 927.4249965021662, 928.3826255540058, 953.3183773601874, 990.0990099009903, 998.5606333213399, 999.5052449037737, 1001.7245257554158, 988.6984469736727, 989.8663680403125, 991.2317953585956, 992.4541502173812, 992.7121134870879, 732.2348146187247, 733.8312188196692, 733.966971486279, 733.9980926035922, 734.4271468254769, 16115.677686446323, 16302.429414970538, 16327.591810204722, 16462.75305870413, 16594.917025414918, 13976.790348144787, 14188.645283867985, 14336.0, 14429.567112986628, 14533.636659083502, 11712.355820429873, 11750.882491175063, 11763.470643821049, 11824.172307938448, 11970.40147992597, 3612.4942508048894, 3664.633536646314, 3719.3491139050557, 3729.2914346274392, 3742.0457783265365, 97277.02722972751, 117620.0, 120367.3981630095, 122247.3887630565, 122466.0, 10875.619353322596, 10950.34297942126, 11034.944825275983, 11089.55641774336, 11140.0, 22877.428064298525, 22902.885485572464, 22951.196708115134, 23184.3044708659, 23328.300150995496, 7344.596047217455, 7543.73596924105, 7577.848443031108, 7645.082590089225, 7680.846383072308, 4225.302825033835, 4383.189110014658, 4393.494748104009, 4426.247537918562, 4479.507254202035, 3554.20030493137, 3666.0, 3666.395044817575, 3667.0832291927018, 3675.338439080991, 612.1063247658468, 629.9874002520015, 639.536336156283, 646.2826262848234, 651.9152510173647, 671.2247354305784, 697.400235797214, 700.3755564951356, 716.4769718105708, 747.622450662412, 9688.564014619358, 10317.638882639221, 10407.635732749317, 10464.790704186025, 10672.57309707603, 646.3310473659834, 657.8486948001986, 685.7641904062518, 693.4036728413561, 697.769735987123, 4993.350864387679, 5024.001908226252, 5026.84919452417, 5035.194368900959, 5038.244263360452, 81460.77808832872, 95046.09907801944, 102730.48634756928, 103888.0, 109103.0, 74145.0, 93091.06908930959, 93722.53138734262, 94065.0, 97423.51288243655, 64926.67536662286, 74686.13284668035, 74990.0, 82767.17232827716, 82998.19012669055, 9814.65648702292, 10846.511906964364, 10868.51091700891, 10964.342139471657, 11273.774524509628, 45987.08025839397, 46010.76994615005, 46320.30519542277, 46902.06195876132, 47615.523844762494, 61052.389476106444, 61447.69276153591, 63288.36711633009, 63529.68235158979, 63927.68036159789, 11075.5569777208, 12660.30368329714, 12681.779616867421, 12684.429200685807, 12968.962483001525, 12368.381580921097, 14482.275886205858, 14503.0, 14821.703565928836, 14826.77759833625, 13034.394245406156, 13159.0, 13163.934180329037, 13569.592912212649, 13775.655608609864, 13316.348195329087, 13513.891804885128, 13656.180629161885, 13816.171029738249, 14108.082974606617, 12939.029572782267, 12951.611451656465, 13567.914566834826, 13647.385867635781, 13956.511522096678, 10680.198985075995, 10937.260088064542, 11212.26209937461, 11217.775644487228, 11441.828372574251, 10546.103581195684, 10615.522301496605, 11190.216684831983, 11362.431878405881, 11383.886161138282], "value": 7669.130977287318, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1431.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 160.0, 172.0, 134.0, 116.0, 114.0, 114.0, 114.0, 114.0, 115.0], "value": 126.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 110.0, 108.0, 143.0, 109.0, 107.0, 105.0, 109.0, 128.0, 107.0], "value": 115.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 180.0, 187.0, 185.0, 182.0, 183.0, 183.0, 182.0, 185.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 61.0, 92.0, 62.0, 61.0, 58.0, 62.0, 77.0, 60.0], "value": 67.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 87.0, 70.0, 69.0, 68.0, 82.0, 70.0, 69.0, 86.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 88.0, 88.0, 89.0, 88.0, 88.0, 88.0, 88.0, 88.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 99.0, 96.0, 108.0, 115.0, 98.0, 96.0, 96.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 86.0, 86.0, 84.0, 85.0, 86.0, 82.0, 82.0, 86.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 61.0, 60.0, 62.0, 63.0, 65.0, 64.0, 64.0, 65.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 60.0, 64.0, 62.0, 60.0, 56.0, 56.0, 56.0, 57.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 87.0, 84.0, 86.0, 85.0, 88.0, 89.0, 110.0, 85.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 145.0, 151.0, 138.0, 139.0, 138.0, 160.0, 144.0, 163.0, 135.0], "value": 145.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 161.0, 164.0, 167.0, 165.0, 165.0, 166.0, 164.0, 162.0, 163.0], "value": 164.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 65.0, 64.0, 64.0, 73.0, 81.0, 80.0, 82.0, 68.0, 64.0], "value": 70.9, "unit": "score"}]}]} 09:14:04 INFO - Return code: 0 09:14:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:14:04 ERROR - # TBPL SUCCESS # 09:14:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:14:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:14:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:14:04 INFO - 2017-03-15 09:14:04.430 screenresolution[1659:10268] starting screenresolution argv=screenresolution get 09:14:04 INFO - 2017-03-15 09:14:04.433 screenresolution[1659:10268] Display 0: 1600x1200x32@60 09:14:04 INFO - 2017-03-15 09:14:04.439 screenresolution[1660:10271] starting screenresolution argv=screenresolution list 09:14:04 INFO - Available Modes on Display 0 09:14:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:14:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:14:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:14:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:14:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:14:04 INFO - Intel Iris: 09:14:04 INFO - Chipset Model: Intel Iris 09:14:04 INFO - Type: GPU 09:14:04 INFO - Bus: Built-In 09:14:04 INFO - VRAM (Dynamic, Max): 1536 MB 09:14:04 INFO - Vendor: Intel (0x8086) 09:14:04 INFO - Device ID: 0x0a2e 09:14:04 INFO - Revision ID: 0x0009 09:14:04 INFO - Displays: 09:14:04 INFO - Display: 09:14:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:14:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:14:04 INFO - Display Serial Number: 1600x1200 60 09:14:04 INFO - Main Display: Yes 09:14:04 INFO - Mirror: Off 09:14:04 INFO - Online: Yes 09:14:04 INFO - Rotation: Supported 09:14:04 INFO - Return code: 0 09:14:04 INFO - Running post-action listener: _resource_record_post_action 09:14:04 INFO - [mozharness: 2017-03-15 16:14:04.676757Z] Finished run-tests step (success) 09:14:04 INFO - Running post-run listener: _resource_record_post_run 09:14:04 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 44475392; Write bytes: 510784000; Read time: 574; Write time: 1792 09:14:04 INFO - TinderboxPrint: CPU usage
53.9% 09:14:04 INFO - TinderboxPrint: I/O read bytes / time
44,475,392 / 574 09:14:04 INFO - TinderboxPrint: I/O write bytes / time
510,784,000 / 1,792 09:14:04 INFO - TinderboxPrint: CPU idle
2,215.2 (46.1%) 09:14:04 INFO - TinderboxPrint: CPU system
959.7 (20.0%) 09:14:04 INFO - TinderboxPrint: CPU user
1,634.8 (34.0%) 09:14:04 INFO - TinderboxPrint: Swap in / out
252,452,864 / 0 09:14:04 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 202723840; Write bytes: 191268864; Read time: 16323; Write time: 420 09:14:04 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 38239232; Write bytes: 298711552; Read time: 492; Write time: 1316 09:14:05 INFO - Running post-run listener: _upload_blobber_files 09:14:05 INFO - Blob upload gear active. 09:14:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:14:05 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 09:14:05 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:14:05 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:14:05 INFO - (blobuploader) - INFO - Open directory for files ... 09:14:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:14:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:14:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:06 INFO - (blobuploader) - INFO - Done attempting. 09:14:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:14:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:14:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:07 INFO - (blobuploader) - INFO - Done attempting. 09:14:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:14:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:08 INFO - (blobuploader) - INFO - Done attempting. 09:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:14:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:14:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:14:10 INFO - (blobuploader) - INFO - Done attempting. 09:14:10 INFO - (blobuploader) - INFO - Iteration through files over. 09:14:10 INFO - Return code: 0 09:14:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:14:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:14:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56247cdd6ab3d85a094908358016395e22318cbe0acbed244b1e3f2c25f0920f61084fb0684e1f3709d1eef35fcb80e13e6d71d2d426e0eb56732a708824ea62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af77a7058f5297a4e5aef201fd5df1edf610c751aeb91a31690986ebb0aaf5f07ed18c4316768ab99e207f2b82be213ef69b3b22b9349c7f5f4f9934b4c4ff48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e68aa1a566adfeb7b828cf94949a9b75cd81497ffb2e3a96b7b0cdec79615d94fc4a4d6e30d4e4bedb6ef9b8bf46c0c4d09439e82922ffcc0ec11661bad0d8c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a37f1c63a902a1950b4b98e1c769ed246448d451aea654d4c07ead87d1ee5f1d16265dde74dde553f693c87f111d2d8722037e6afe0ca305e7b55468e025d03"} 09:14:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:14:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:14:10 INFO - Contents: 09:14:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56247cdd6ab3d85a094908358016395e22318cbe0acbed244b1e3f2c25f0920f61084fb0684e1f3709d1eef35fcb80e13e6d71d2d426e0eb56732a708824ea62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af77a7058f5297a4e5aef201fd5df1edf610c751aeb91a31690986ebb0aaf5f07ed18c4316768ab99e207f2b82be213ef69b3b22b9349c7f5f4f9934b4c4ff48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e68aa1a566adfeb7b828cf94949a9b75cd81497ffb2e3a96b7b0cdec79615d94fc4a4d6e30d4e4bedb6ef9b8bf46c0c4d09439e82922ffcc0ec11661bad0d8c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a37f1c63a902a1950b4b98e1c769ed246448d451aea654d4c07ead87d1ee5f1d16265dde74dde553f693c87f111d2d8722037e6afe0ca305e7b55468e025d03"} 09:14:10 INFO - Running post-run listener: copy_logs_to_upload_dir 09:14:10 INFO - Copying logs to upload dir... 09:14:10 INFO - mkdir: /builds/slave/test/build/upload/logs 09:14:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.362274 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-15 09:14:10.953889) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:14:10.957177) ========= 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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56247cdd6ab3d85a094908358016395e22318cbe0acbed244b1e3f2c25f0920f61084fb0684e1f3709d1eef35fcb80e13e6d71d2d426e0eb56732a708824ea62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af77a7058f5297a4e5aef201fd5df1edf610c751aeb91a31690986ebb0aaf5f07ed18c4316768ab99e207f2b82be213ef69b3b22b9349c7f5f4f9934b4c4ff48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e68aa1a566adfeb7b828cf94949a9b75cd81497ffb2e3a96b7b0cdec79615d94fc4a4d6e30d4e4bedb6ef9b8bf46c0c4d09439e82922ffcc0ec11661bad0d8c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a37f1c63a902a1950b4b98e1c769ed246448d451aea654d4c07ead87d1ee5f1d16265dde74dde553f693c87f111d2d8722037e6afe0ca305e7b55468e025d03"} build_url:https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011279 build_url: 'https://queue.taskcluster.net/v1/task/ZHCR6iIaRiioMPIZAq9B5Q/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/56247cdd6ab3d85a094908358016395e22318cbe0acbed244b1e3f2c25f0920f61084fb0684e1f3709d1eef35fcb80e13e6d71d2d426e0eb56732a708824ea62", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/af77a7058f5297a4e5aef201fd5df1edf610c751aeb91a31690986ebb0aaf5f07ed18c4316768ab99e207f2b82be213ef69b3b22b9349c7f5f4f9934b4c4ff48", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e68aa1a566adfeb7b828cf94949a9b75cd81497ffb2e3a96b7b0cdec79615d94fc4a4d6e30d4e4bedb6ef9b8bf46c0c4d09439e82922ffcc0ec11661bad0d8c1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/6a37f1c63a902a1950b4b98e1c769ed246448d451aea654d4c07ead87d1ee5f1d16265dde74dde553f693c87f111d2d8722037e6afe0ca305e7b55468e025d03"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 09:14:10.991878) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:14:10.992252) ========= 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.hKXSJkjpQv/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.JCbpJeJ4wI/Listeners TMPDIR=/var/folders/8g/gc76032d21n7d6r0hkpdqbjr00000w/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.005371 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 09:14:11.042321) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:14:11.042710) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 09:14:11.043091) ========= ========= Total master_lag: 1.06 =========