builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0004 starttime: 1490281082.66 results: success (0) buildid: 20170323062324 builduid: d212807d0fa645bb99bfde195423037d revision: 8e41b1af3cd4e88f65cf092891c050a9206c3990 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:02.657596) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:02.658341) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:02.658690) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:02.684809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:02.685201) ========= 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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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-23 07:58:02-- 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% 7.97M=0.001s 2017-03-23 07:58:02 (7.97 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137805 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:02.846548) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:02.846901) ========= 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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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.023282 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:02.896857) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 07:58:02.897217) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8e41b1af3cd4e88f65cf092891c050a9206c3990 --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 8e41b1af3cd4e88f65cf092891c050a9206c3990 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.tORX7AF2Rb/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.5PWqDDsrOL/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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-23 07:58:02,986 truncating revision to first 12 chars 2017-03-23 07:58:02,986 Setting DEBUG logging. 2017-03-23 07:58:02,986 attempt 1/10 2017-03-23 07:58:02,986 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8e41b1af3cd4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 07:58:04,033 unpacking tar archive at: mozilla-aurora-8e41b1af3cd4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.310137 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 07:58:04.230992) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:04.231317) ========= script_repo_revision: 8e41b1af3cd4e88f65cf092891c050a9206c3990 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:04.231721) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:04.232062) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 07:58:04.252194) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-23 07:58:04.252635) ========= /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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:58:04 INFO - MultiFileLogger online at 20170323 07:58:04 in /builds/slave/test 07:58:04 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 07:58:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:58:04 INFO - {'append_to_log': False, 07:58:04 INFO - 'base_work_dir': '/builds/slave/test', 07:58:04 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:58:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:58:04 INFO - 'branch': 'Mozilla-Aurora', 07:58:04 INFO - 'buildbot_json_path': 'buildprops.json', 07:58:04 INFO - 'config_files': ('talos/mac_config.py',), 07:58:04 INFO - 'default_actions': ('clobber', 07:58:04 INFO - 'read-buildbot-config', 07:58:04 INFO - 'download-and-extract', 07:58:04 INFO - 'populate-webroot', 07:58:04 INFO - 'create-virtualenv', 07:58:04 INFO - 'install', 07:58:04 INFO - 'run-tests'), 07:58:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:58:04 INFO - 'download_minidump_stackwalk': True, 07:58:04 INFO - 'download_symbols': 'ondemand', 07:58:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:58:04 INFO - 'tooltool.py': '/tools/tooltool.py', 07:58:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:58:04 INFO - '/tools/misc-python/virtualenv.py')}, 07:58:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:58:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:58:04 INFO - 'gecko_profile': False, 07:58:04 INFO - 'gecko_profile_interval': 0, 07:58:04 INFO - 'installer_path': 'installer.exe', 07:58:04 INFO - 'log_level': 'info', 07:58:04 INFO - 'log_name': 'talos', 07:58:04 INFO - 'log_to_console': True, 07:58:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:58:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:58:04 INFO - 'opt_config_files': (), 07:58:04 INFO - 'pip_index': False, 07:58:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:58:04 INFO - 'cmd': ('bash', 07:58:04 INFO - '-c', 07:58:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:58:04 INFO - 'enabled': True, 07:58:04 INFO - 'halt_on_failure': False, 07:58:04 INFO - 'name': 'check_screen_resolution'},), 07:58:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:58:04 INFO - 'cmd': ('bash', 07:58:04 INFO - '-c', 07:58:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:58:04 INFO - 'enabled': True, 07:58:04 INFO - 'halt_on_failure': False, 07:58:04 INFO - 'name': 'check_screen_resolution'},), 07:58:04 INFO - 'run_cmd_checks_enabled': True, 07:58:04 INFO - 'suite': 'dromaeojs', 07:58:04 INFO - 'system_bits': '32', 07:58:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:58:04 INFO - 'title': 't-yosemite-r7-0004', 07:58:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:58:04 INFO - 'use_talos_json': True, 07:58:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:58:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:58:04 INFO - 'work_dir': 'build'} 07:58:04 INFO - [mozharness: 2017-03-23 14:58:04.463150Z] Running clobber step. 07:58:04 INFO - Running pre-action listener: _resource_record_pre_action 07:58:04 INFO - Running main action method: clobber 07:58:04 INFO - rmtree: /builds/slave/test/build 07:58:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:58:06 INFO - Running post-action listener: _resource_record_post_action 07:58:06 INFO - [mozharness: 2017-03-23 14:58:06.547099Z] Finished clobber step (success) 07:58:06 INFO - [mozharness: 2017-03-23 14:58:06.547248Z] Running read-buildbot-config step. 07:58:06 INFO - Running pre-action listener: _resource_record_pre_action 07:58:06 INFO - Running main action method: read_buildbot_config 07:58:06 INFO - Using buildbot properties: 07:58:06 INFO - { 07:58:06 INFO - "project": "", 07:58:06 INFO - "product": "firefox", 07:58:06 INFO - "script_repo_revision": "production", 07:58:06 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 07:58:06 INFO - "repository": "", 07:58:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 07:58:06 INFO - "buildid": "20170323062324", 07:58:06 INFO - "pgo_build": "False", 07:58:06 INFO - "basedir": "/builds/slave/test", 07:58:06 INFO - "buildnumber": 2, 07:58:06 INFO - "slavename": "t-yosemite-r7-0004", 07:58:06 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 07:58:06 INFO - "platform": "yosemite_r7", 07:58:06 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 07:58:06 INFO - "branch": "mozilla-aurora", 07:58:06 INFO - "repo_path": "releases/mozilla-aurora", 07:58:06 INFO - "revision": "8e41b1af3cd4e88f65cf092891c050a9206c3990", 07:58:06 INFO - "stage_platform": "macosx64", 07:58:06 INFO - "builduid": "d212807d0fa645bb99bfde195423037d", 07:58:06 INFO - "slavebuilddir": "test" 07:58:06 INFO - } 07:58:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 07:58:06 INFO - Running post-action listener: _resource_record_post_action 07:58:06 INFO - [mozharness: 2017-03-23 14:58:06.550601Z] Finished read-buildbot-config step (success) 07:58:06 INFO - [mozharness: 2017-03-23 14:58:06.550739Z] Running download-and-extract step. 07:58:06 INFO - Running pre-action listener: _resource_record_pre_action 07:58:06 INFO - Running main action method: download_and_extract 07:58:06 INFO - mkdir: /builds/slave/test/build/tests 07:58:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:06 INFO - trying https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 07:58:06 INFO - Downloading https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/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 07:58:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/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 07:58:07 INFO - Downloaded 1199 bytes. 07:58:07 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 07:58:07 INFO - Using the following test package requirements: 07:58:07 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:58:07 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:58:07 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 07:58:07 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:58:07 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 07:58:07 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:58:07 INFO - u'jsshell-mac.zip'], 07:58:07 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:58:07 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 07:58:07 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 07:58:07 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:58:07 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 07:58:07 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:58:07 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 07:58:07 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:58:07 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 07:58:07 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 07:58:07 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 07:58:07 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 07:58:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:58:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:58:07 INFO - Fetch https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:58:09 INFO - Expected file size: 51782392 07:58:09 INFO - Obtained file size: 51782392 07:58:25 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 07:58:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 07:58:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 07:58:25 INFO - Fetch https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 07:58:27 INFO - Expected file size: 51782392 07:58:27 INFO - Obtained file size: 51782392 07:58:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 07:58:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 07:58:42 INFO - Fetch https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 07:58:43 INFO - Expected file size: 14404438 07:58:43 INFO - Obtained file size: 14404438 07:58:43 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')]} 07:58:43 INFO - trying https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:58:43 INFO - Downloading https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 07:58:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/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 07:58:45 INFO - Downloaded 74760823 bytes. 07:58:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:58:45 INFO - mkdir: /builds/slave/test/properties 07:58:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:58:45 INFO - Writing to file /builds/slave/test/properties/build_url 07:58:45 INFO - Contents: 07:58:45 INFO - build_url:https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 07:58:46 INFO - Running post-action listener: _resource_record_post_action 07:58:46 INFO - Running post-action listener: set_extra_try_arguments 07:58:46 INFO - [mozharness: 2017-03-23 14:58:46.431255Z] Finished download-and-extract step (success) 07:58:46 INFO - [mozharness: 2017-03-23 14:58:46.431378Z] Running populate-webroot step. 07:58:46 INFO - Running pre-action listener: _resource_record_pre_action 07:58:46 INFO - Running main action method: populate_webroot 07:58:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:58:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:58:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:58:46 INFO - '--tppagecycles', 07:58:46 INFO - '7'], 07:58:46 INFO - 'tests': ['tsvgm']}}, 07:58:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:58:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:58:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:58:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:58:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:58:46 INFO - 'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:58:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:58:46 INFO - 'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['damp', 'tps']}, 07:58:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:58:46 INFO - 'tests': ['damp', 'tps']}, 07:58:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['dromaeo_dom']}, 07:58:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:58:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['basic_compositor_video']}, 07:58:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:58:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['a11yr', 07:58:46 INFO - 'ts_paint', 07:58:46 INFO - 'tpaint', 07:58:46 INFO - 'sessionrestore', 07:58:46 INFO - 'sessionrestore_no_auto_restore', 07:58:46 INFO - 'tabpaint']}, 07:58:46 INFO - 'other-e10s': {'tests': ['a11yr', 07:58:46 INFO - 'ts_paint', 07:58:46 INFO - 'tpaint', 07:58:46 INFO - 'sessionrestore', 07:58:46 INFO - 'sessionrestore_no_auto_restore', 07:58:46 INFO - 'tabpaint']}, 07:58:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:58:46 INFO - 'ts_paint', 07:58:46 INFO - 'tpaint', 07:58:46 INFO - 'sessionrestore', 07:58:46 INFO - 'sessionrestore_no_auto_restore', 07:58:46 INFO - 'tabpaint']}, 07:58:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:58:46 INFO - 'ts_paint', 07:58:46 INFO - 'tpaint', 07:58:46 INFO - 'sessionrestore', 07:58:46 INFO - 'sessionrestore_no_auto_restore', 07:58:46 INFO - 'tabpaint']}, 07:58:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['a11yr', 07:58:46 INFO - 'ts_paint', 07:58:46 INFO - 'tpaint', 07:58:46 INFO - 'sessionrestore', 07:58:46 INFO - 'sessionrestore_no_auto_restore', 07:58:46 INFO - 'tabpaint']}, 07:58:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['a11yr', 07:58:46 INFO - 'ts_paint', 07:58:46 INFO - 'tpaint', 07:58:46 INFO - 'sessionrestore', 07:58:46 INFO - 'sessionrestore_no_auto_restore', 07:58:46 INFO - 'tabpaint']}, 07:58:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['tsvgx', 07:58:46 INFO - 'tsvgr_opacity', 07:58:46 INFO - 'tart', 07:58:46 INFO - 'tscrollx', 07:58:46 INFO - 'cart', 07:58:46 INFO - 'tsvg_static']}, 07:58:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:58:46 INFO - 'tsvgr_opacity', 07:58:46 INFO - 'tart', 07:58:46 INFO - 'tscrollx', 07:58:46 INFO - 'cart', 07:58:46 INFO - 'tsvg_static']}, 07:58:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:58:46 INFO - 'talos_options': ['--disable-e10s'], 07:58:46 INFO - 'tests': ['tp5o']}, 07:58:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:58:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:58:46 INFO - 'talos_options': ['--disable-e10s', 07:58:46 INFO - '--xperf_path', 07:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:46 INFO - 'tests': ['tp5n']}, 07:58:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:58:46 INFO - 'talos_options': ['--xperf_path', 07:58:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:46 INFO - 'tests': ['tp5n']}}, 07:58:46 INFO - 'talos.zip': {'path': '', 07:58:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:58:46 INFO - Running post-action listener: _resource_record_post_action 07:58:46 INFO - [mozharness: 2017-03-23 14:58:46.449561Z] Finished populate-webroot step (success) 07:58:46 INFO - [mozharness: 2017-03-23 14:58:46.449694Z] Running create-virtualenv step. 07:58:46 INFO - Running pre-action listener: _resource_record_pre_action 07:58:46 INFO - Running main action method: create_virtualenv 07:58:46 INFO - Creating virtualenv /builds/slave/test/build/venv 07:58:46 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 07:58:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:58:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:58:46 INFO - Using real prefix '/tools/python27' 07:58:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:58:47 INFO - Installing distribute.............................................................................................................................................................................................done. 07:58:50 INFO - Installing pip.................done. 07:58:50 INFO - Return code: 0 07:58:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:58:50 INFO - Reading from file tmpfile_stdout 07:58:50 INFO - Output received: 07:58:50 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) 07:58:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:58:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:58:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:58:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:50 INFO - 'HOME': '/Users/cltbld', 07:58:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:50 INFO - 'LOGNAME': 'cltbld', 07:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:50 INFO - 'MOZ_NO_REMOTE': '1', 07:58:50 INFO - 'NO_EM_RESTART': '1', 07:58:50 INFO - 'PAGER': '/bin/cat', 07:58:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:50 INFO - 'PWD': '/builds/slave/test', 07:58:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:50 INFO - 'SHELL': '/bin/bash', 07:58:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:58:50 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:58:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:50 INFO - 'USER': 'cltbld', 07:58:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:50 INFO - 'XPC_FLAGS': '0x0', 07:58:50 INFO - 'XPC_SERVICE_NAME': '0', 07:58:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:50 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 07:58:50 INFO - Cleaning up... 07:58:50 INFO - Return code: 0 07:58:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:58:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:58:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:58:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:58:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:50 INFO - 'HOME': '/Users/cltbld', 07:58:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:50 INFO - 'LOGNAME': 'cltbld', 07:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:50 INFO - 'MOZ_NO_REMOTE': '1', 07:58:50 INFO - 'NO_EM_RESTART': '1', 07:58:50 INFO - 'PAGER': '/bin/cat', 07:58:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:50 INFO - 'PWD': '/builds/slave/test', 07:58:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:50 INFO - 'SHELL': '/bin/bash', 07:58:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:58:50 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:58:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:50 INFO - 'USER': 'cltbld', 07:58:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:50 INFO - 'XPC_FLAGS': '0x0', 07:58:50 INFO - 'XPC_SERVICE_NAME': '0', 07:58:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:50 INFO - Downloading/unpacking psutil>=3.1.1 07:58:50 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 07:58:50 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 07:58:50 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 07:58:50 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 07:58:50 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 07:58:50 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 07:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:58:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:54 INFO - Installing collected packages: psutil 07:58:54 INFO - Running setup.py install for psutil 07:58:54 INFO - building 'psutil._psutil_osx' extension 07:58:54 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 07:58:54 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 07:58:55 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 07:58:55 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 07:58:55 INFO - building 'psutil._psutil_posix' extension 07:58:55 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 07:58:55 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:58:55 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:58:55 INFO - ^ 07:58:55 INFO - 1 warning generated. 07:58:55 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 07:58:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:55 INFO - Successfully installed psutil 07:58:55 INFO - Cleaning up... 07:58:55 INFO - Return code: 0 07:58:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:58: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')]} 07:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58: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')]} 07:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:55 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 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:58:55 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 07:58:55 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 07:58:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:58:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:55 INFO - 'HOME': '/Users/cltbld', 07:58:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:55 INFO - 'LOGNAME': 'cltbld', 07:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:55 INFO - 'MOZ_NO_REMOTE': '1', 07:58:55 INFO - 'NO_EM_RESTART': '1', 07:58:55 INFO - 'PAGER': '/bin/cat', 07:58:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:55 INFO - 'PWD': '/builds/slave/test', 07:58:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:55 INFO - 'SHELL': '/bin/bash', 07:58:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:58:55 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:58:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:55 INFO - 'USER': 'cltbld', 07:58:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:55 INFO - 'XPC_FLAGS': '0x0', 07:58:55 INFO - 'XPC_SERVICE_NAME': '0', 07:58:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:58:55 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 07:58:55 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 07:58:55 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 07:58:55 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 07:58:55 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 07:58:55 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 07:58:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:58:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:58:58 INFO - Installing collected packages: mozsystemmonitor 07:58:58 INFO - Running setup.py install for mozsystemmonitor 07:58:58 INFO - Successfully installed mozsystemmonitor 07:58:58 INFO - Cleaning up... 07:58:58 INFO - Return code: 0 07:58:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:58:58 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')]} 07:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:58:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:58:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:58:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:59 INFO - 'HOME': '/Users/cltbld', 07:58:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:59 INFO - 'LOGNAME': 'cltbld', 07:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:59 INFO - 'MOZ_NO_REMOTE': '1', 07:58:59 INFO - 'NO_EM_RESTART': '1', 07:58:59 INFO - 'PAGER': '/bin/cat', 07:58:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:59 INFO - 'PWD': '/builds/slave/test', 07:58:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:59 INFO - 'SHELL': '/bin/bash', 07:58:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:58:59 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:58:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:59 INFO - 'USER': 'cltbld', 07:58:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:59 INFO - 'XPC_FLAGS': '0x0', 07:58:59 INFO - 'XPC_SERVICE_NAME': '0', 07:58:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:59 INFO - Downloading/unpacking jsonschema==2.5.1 07:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:59:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:02 INFO - Downloading functools32-3.2.3-2.tar.gz 07:59:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:59:03 INFO - warning: no files found matching '*.txt' 07:59:03 INFO - no previously-included directories found matching 'build' 07:59:03 INFO - no previously-included directories found matching 'dist' 07:59:03 INFO - no previously-included directories found matching '.git*' 07:59:03 INFO - Installing collected packages: jsonschema, functools32 07:59:03 INFO - Running setup.py install for functools32 07:59:03 INFO - warning: no files found matching '*.txt' 07:59:03 INFO - no previously-included directories found matching 'build' 07:59:03 INFO - no previously-included directories found matching 'dist' 07:59:03 INFO - no previously-included directories found matching '.git*' 07:59:03 INFO - Successfully installed jsonschema functools32 07:59:03 INFO - Cleaning up... 07:59:03 INFO - Return code: 0 07:59:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:59:03 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')]} 07:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:03 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')]} 07:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:03 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 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:59:03 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 07:59:03 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 07:59:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:59:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:03 INFO - 'HOME': '/Users/cltbld', 07:59:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:03 INFO - 'LOGNAME': 'cltbld', 07:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:03 INFO - 'MOZ_NO_REMOTE': '1', 07:59:03 INFO - 'NO_EM_RESTART': '1', 07:59:03 INFO - 'PAGER': '/bin/cat', 07:59:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:03 INFO - 'PWD': '/builds/slave/test', 07:59:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:03 INFO - 'SHELL': '/bin/bash', 07:59:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:59:03 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:59:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:03 INFO - 'USER': 'cltbld', 07:59:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:03 INFO - 'XPC_FLAGS': '0x0', 07:59:03 INFO - 'XPC_SERVICE_NAME': '0', 07:59:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:59:03 INFO - Cleaning up... 07:59:03 INFO - Return code: 0 07:59:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:59:03 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')]} 07:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:03 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')]} 07:59:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:03 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 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:59:03 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 07:59:03 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 07:59:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:59:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:03 INFO - 'HOME': '/Users/cltbld', 07:59:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:03 INFO - 'LOGNAME': 'cltbld', 07:59:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:03 INFO - 'MOZ_NO_REMOTE': '1', 07:59:03 INFO - 'NO_EM_RESTART': '1', 07:59:03 INFO - 'PAGER': '/bin/cat', 07:59:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:03 INFO - 'PWD': '/builds/slave/test', 07:59:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:03 INFO - 'SHELL': '/bin/bash', 07:59:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:59:03 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:59:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:03 INFO - 'USER': 'cltbld', 07:59:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:03 INFO - 'XPC_FLAGS': '0x0', 07:59:03 INFO - 'XPC_SERVICE_NAME': '0', 07:59:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:03 INFO - Downloading/unpacking blobuploader==1.2.4 07:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:06 INFO - Downloading blobuploader-1.2.4.tar.gz 07:59:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:59:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:59:06 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 07:59:06 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 07:59:06 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 07:59:06 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 07:59:06 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 07:59:06 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 07:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:59:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:59:07 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 07:59:07 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 07:59:07 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 07:59:07 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 07:59:07 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 07:59:07 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 07:59:07 INFO - Downloading docopt-0.6.1.tar.gz 07:59:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:59:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:59:07 INFO - Running setup.py install for blobuploader 07:59:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:59:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:59:08 INFO - Running setup.py install for requests 07:59:08 INFO - Running setup.py install for docopt 07:59:08 INFO - Successfully installed blobuploader requests docopt 07:59:08 INFO - Cleaning up... 07:59:08 INFO - Return code: 0 07:59:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:08 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 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:59:08 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 07:59:08 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 07:59:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:59:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:08 INFO - 'HOME': '/Users/cltbld', 07:59:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:08 INFO - 'LOGNAME': 'cltbld', 07:59:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:08 INFO - 'MOZ_NO_REMOTE': '1', 07:59:08 INFO - 'NO_EM_RESTART': '1', 07:59:08 INFO - 'PAGER': '/bin/cat', 07:59:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:08 INFO - 'PWD': '/builds/slave/test', 07:59:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:08 INFO - 'SHELL': '/bin/bash', 07:59:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:59:08 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:59:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:08 INFO - 'USER': 'cltbld', 07:59:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:08 INFO - 'XPC_FLAGS': '0x0', 07:59:08 INFO - 'XPC_SERVICE_NAME': '0', 07:59:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:09 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-byEb3p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:09 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-hH9ReH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:09 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-weAF2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:09 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-hjsUp5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:09 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-fKrr2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:09 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-Eht1Jt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:09 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-bfpQdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:09 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-U_iDEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:09 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-iIfhWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:10 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-kUs2Sg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:10 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-FhzbaX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:10 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-ke4Ze9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:10 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-2sOoFm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:10 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-MLu0UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:10 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-mCk4Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:10 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-3xxWeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:10 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-AlPNKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:10 INFO - Running setup.py install for manifestparser 07:59:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:59:11 INFO - Running setup.py install for mozcrash 07:59:11 INFO - Running setup.py install for mozdebug 07:59:11 INFO - Running setup.py install for mozdevice 07:59:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:59:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:59:11 INFO - Running setup.py install for mozfile 07:59:11 INFO - Running setup.py install for mozhttpd 07:59:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:59:11 INFO - Running setup.py install for mozinfo 07:59:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:59:11 INFO - Running setup.py install for mozInstall 07:59:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:59:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:59:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:59:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:59:12 INFO - Running setup.py install for mozleak 07:59:12 INFO - Running setup.py install for mozlog 07:59:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:59:12 INFO - Running setup.py install for moznetwork 07:59:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:59:12 INFO - Running setup.py install for mozprocess 07:59:12 INFO - Running setup.py install for mozprofile 07:59:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:59:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:59:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:59:12 INFO - Running setup.py install for mozrunner 07:59:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:59:13 INFO - Running setup.py install for mozscreenshot 07:59:13 INFO - Running setup.py install for moztest 07:59:13 INFO - Running setup.py install for mozversion 07:59:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:59:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:59:13 INFO - Cleaning up... 07:59:13 INFO - Return code: 0 07:59:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:13 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 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:59:13 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 07:59:13 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 07:59:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:59:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:13 INFO - 'HOME': '/Users/cltbld', 07:59:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:13 INFO - 'LOGNAME': 'cltbld', 07:59:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:13 INFO - 'MOZ_NO_REMOTE': '1', 07:59:13 INFO - 'NO_EM_RESTART': '1', 07:59:13 INFO - 'PAGER': '/bin/cat', 07:59:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:13 INFO - 'PWD': '/builds/slave/test', 07:59:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:13 INFO - 'SHELL': '/bin/bash', 07:59:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:59:13 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:59:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:13 INFO - 'USER': 'cltbld', 07:59:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:13 INFO - 'XPC_FLAGS': '0x0', 07:59:13 INFO - 'XPC_SERVICE_NAME': '0', 07:59:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:13 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-ZF3PhM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:13 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)) 07:59:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:13 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-7Fx1n2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-Y2YnBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-Lf4Ovg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-yCswRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-tGL7GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-_QhNf3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-9PvVCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-Qk8xzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-DQUAqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-2TxC5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:14 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)) 07:59:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:14 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-h5ve4h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:15 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)) 07:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-smCyVm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:15 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)) 07:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-DszvWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:15 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)) 07:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-tvJj82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:15 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)) 07:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-Lx5PsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:15 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)) 07:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:15 INFO - Running setup.py (path:/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/pip-VKafR4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:15 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)) 07:59:15 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)) 07:59:15 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)) 07:59:15 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)) 07:59:15 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)) 07:59:15 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)) 07:59:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:59:15 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 07:59:15 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 07:59:15 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 07:59:15 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 07:59:15 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 07:59:15 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 07:59:18 INFO - Downloading blessings-1.6.tar.gz 07:59:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:59:18 INFO - Installing collected packages: blessings 07:59:18 INFO - Running setup.py install for blessings 07:59:18 INFO - Successfully installed blessings 07:59:18 INFO - Cleaning up... 07:59:18 INFO - Return code: 0 07:59:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:59:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:18 INFO - Reading from file tmpfile_stdout 07:59:18 INFO - Current package versions: 07:59:18 INFO - blessings == 1.6 07:59:18 INFO - blobuploader == 1.2.4 07:59:18 INFO - docopt == 0.6.1 07:59:18 INFO - functools32 == 3.2.3-2 07:59:18 INFO - jsonschema == 2.5.1 07:59:18 INFO - manifestparser == 1.1 07:59:18 INFO - mozInstall == 1.12 07:59:18 INFO - mozcrash == 1.0 07:59:18 INFO - mozdebug == 0.1 07:59:18 INFO - mozdevice == 0.49 07:59:18 INFO - mozfile == 1.2 07:59:18 INFO - mozhttpd == 0.7 07:59:18 INFO - mozinfo == 0.9 07:59:18 INFO - mozleak == 0.1 07:59:18 INFO - mozlog == 3.4 07:59:18 INFO - moznetwork == 0.27 07:59:18 INFO - mozprocess == 0.25 07:59:18 INFO - mozprofile == 0.28 07:59:18 INFO - mozrunner == 6.13 07:59:18 INFO - mozscreenshot == 0.1 07:59:18 INFO - mozsystemmonitor == 0.3 07:59:18 INFO - moztest == 0.8 07:59:18 INFO - mozversion == 1.4 07:59:18 INFO - psutil == 3.1.1 07:59:18 INFO - requests == 1.2.3 07:59:18 INFO - wsgiref == 0.1.2 07:59:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:18 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 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:59:18 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 07:59:18 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 07:59:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:59:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:18 INFO - 'HOME': '/Users/cltbld', 07:59:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:18 INFO - 'LOGNAME': 'cltbld', 07:59:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:18 INFO - 'MOZ_NO_REMOTE': '1', 07:59:18 INFO - 'NO_EM_RESTART': '1', 07:59:18 INFO - 'PAGER': '/bin/cat', 07:59:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:18 INFO - 'PWD': '/builds/slave/test', 07:59:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:18 INFO - 'SHELL': '/bin/bash', 07:59:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:59:18 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:59:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:18 INFO - 'USER': 'cltbld', 07:59:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:18 INFO - 'XPC_FLAGS': '0x0', 07:59:18 INFO - 'XPC_SERVICE_NAME': '0', 07:59:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:19 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)) 07:59:19 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)) 07:59:19 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)) 07:59:19 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)) 07:59:19 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)) 07:59:19 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)) 07:59:19 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)) 07:59:19 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)) 07:59:19 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)) 07:59:19 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)) 07:59:19 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)) 07:59:19 INFO - Cleaning up... 07:59:19 INFO - Return code: 0 07:59:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:19 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 0x1104e6b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104e9768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb793c94130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, '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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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 07:59:19 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 07:59:19 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 07:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:19 INFO - 'HOME': '/Users/cltbld', 07:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:19 INFO - 'LOGNAME': 'cltbld', 07:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:19 INFO - 'MOZ_NO_REMOTE': '1', 07:59:19 INFO - 'NO_EM_RESTART': '1', 07:59:19 INFO - 'PAGER': '/bin/cat', 07:59:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:19 INFO - 'PWD': '/builds/slave/test', 07:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:19 INFO - 'SHELL': '/bin/bash', 07:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:59:19 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:19 INFO - 'USER': 'cltbld', 07:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:19 INFO - 'XPC_FLAGS': '0x0', 07:59:19 INFO - 'XPC_SERVICE_NAME': '0', 07:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:59:19 INFO - Cleaning up... 07:59:19 INFO - Return code: 0 07:59:19 INFO - Running post-action listener: _resource_record_post_action 07:59:19 INFO - Running post-action listener: _start_resource_monitoring 07:59:19 INFO - Starting resource monitoring. 07:59:19 INFO - [mozharness: 2017-03-23 14:59:19.439463Z] Finished create-virtualenv step (success) 07:59:19 INFO - [mozharness: 2017-03-23 14:59:19.440539Z] Running install step. 07:59:19 INFO - Running pre-action listener: _resource_record_pre_action 07:59:19 INFO - Running main action method: install 07:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:19 INFO - Reading from file tmpfile_stdout 07:59:19 INFO - Detecting whether we're running mozinstall >=1.0... 07:59:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:59:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:59:19 INFO - Reading from file tmpfile_stdout 07:59:19 INFO - Output received: 07:59:19 INFO - Usage: mozinstall [options] installer 07:59:19 INFO - Options: 07:59:19 INFO - -h, --help show this help message and exit 07:59:19 INFO - -d DEST, --destination=DEST 07:59:19 INFO - Directory to install application into. [default: 07:59:19 INFO - "/builds/slave/test"] 07:59:19 INFO - --app=APP Application being installed. [default: firefox] 07:59:19 INFO - mkdir: /builds/slave/test/build/application 07:59:19 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'] 07:59:19 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 07:59:39 INFO - Reading from file tmpfile_stdout 07:59:39 INFO - Output received: 07:59:39 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 07:59:39 INFO - Running post-action listener: _resource_record_post_action 07:59:39 INFO - [mozharness: 2017-03-23 14:59:39.974303Z] Finished install step (success) 07:59:39 INFO - [mozharness: 2017-03-23 14:59:39.974453Z] Running run-tests step. 07:59:39 INFO - Running pre-action listener: _resource_record_pre_action 07:59:39 INFO - Running main action method: run_tests 07:59:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:59:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:59:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:59:39 INFO - 2017-03-23 07:59:39.989 screenresolution[2454:34806] starting screenresolution argv=screenresolution get 07:59:39 INFO - 2017-03-23 07:59:39.992 screenresolution[2454:34806] Display 0: 1600x1200x32@60 07:59:39 INFO - 2017-03-23 07:59:39.998 screenresolution[2455:34808] starting screenresolution argv=screenresolution list 07:59:40 INFO - Available Modes on Display 0 07:59:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:59:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:59:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:59:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:59:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:59:40 INFO - Intel Iris: 07:59:40 INFO - Chipset Model: Intel Iris 07:59:40 INFO - Type: GPU 07:59:40 INFO - Bus: Built-In 07:59:40 INFO - VRAM (Dynamic, Max): 1536 MB 07:59:40 INFO - Vendor: Intel (0x8086) 07:59:40 INFO - Device ID: 0x0a2e 07:59:40 INFO - Revision ID: 0x0009 07:59:40 INFO - Displays: 07:59:40 INFO - Display: 07:59:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:59:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:59:40 INFO - Display Serial Number: 1600x1200 60 07:59:40 INFO - Main Display: Yes 07:59:40 INFO - Mirror: Off 07:59:40 INFO - Online: Yes 07:59:40 INFO - Rotation: Supported 07:59:40 INFO - Return code: 0 07:59:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:59:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:59:40 INFO - Python 2.7.3 07:59:40 INFO - Return code: 0 07:59:40 INFO - grabbing minidump binary from tooltool 07:59:40 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')]} 07:59:40 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 0x1102c4d30>, '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 0x1101ebdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1102b9be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:59:40 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 07:59:40 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 07:59:40 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 07:59:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:59:40 INFO - Return code: 0 07:59:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:59:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:59:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:59:40 INFO - ENV: RUST_BACKTRACE is now 1 07:59:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:59:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:59:40 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/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--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 07:59:40 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/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0004 --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 07:59:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.tORX7AF2Rb/Render', 07:59:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:59:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:59:40 INFO - 'HOME': '/Users/cltbld', 07:59:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:59:40 INFO - 'LOGNAME': 'cltbld', 07:59:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:59:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:40 INFO - 'MOZ_NO_REMOTE': '1', 07:59:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:59:40 INFO - 'NO_EM_RESTART': '1', 07:59:40 INFO - 'PAGER': '/bin/cat', 07:59:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:40 INFO - 'PWD': '/builds/slave/test', 07:59:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:59:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:59:40 INFO - 'RUST_BACKTRACE': '1', 07:59:40 INFO - 'SHELL': '/bin/bash', 07:59:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.5PWqDDsrOL/Listeners', 07:59:40 INFO - 'TMPDIR': '/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/', 07:59:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:59:40 INFO - 'USER': 'cltbld', 07:59:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:59:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:40 INFO - 'XPC_FLAGS': '0x0', 07:59:40 INFO - 'XPC_SERVICE_NAME': '0', 07:59:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:59:40 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/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0004', '--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 07:59:40 INFO - mozversion application_buildid: 20170323062324 07:59:40 INFO - mozversion application_changeset: 8e41b1af3cd4e88f65cf092891c050a9206c3990 07:59:40 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:59:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:59:40 INFO - mozversion application_name: Firefox 07:59:40 INFO - mozversion application_remotingname: firefox-dev 07:59:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:59:40 INFO - mozversion application_vendor: Mozilla 07:59:40 INFO - mozversion application_version: 54.0a2 07:59:40 INFO - mozversion platform_buildid: 20170323062324 07:59:40 INFO - mozversion platform_changeset: 8e41b1af3cd4e88f65cf092891c050a9206c3990 07:59:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:59:40 INFO - mozversion platform_version: 54.0a2 07:59:40 INFO - using testdate: 1490281180 07:59:40 INFO - actual date: 1490281180 07:59:40 INFO - starting webserver on 'localhost:62309' 07:59:40 INFO - SUITE-START | Running 2 tests 07:59:40 INFO - TEST-START | dromaeo_css 07:59:40 INFO - operating with platform_type : mac_ 07:59:40 INFO - Initialising browser for dromaeo_css test... 07:59:40 INFO - TEST-INFO | started process 2465 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/tmpvzCry9/profile http://localhost:62309/getInfo.html) 07:59:42 INFO - PROCESS | 2465 | __metrics Screen width/height:1600/1200 07:59:42 INFO - PROCESS | 2465 | colorDepth:24 07:59:42 INFO - PROCESS | 2465 | Browser inner width/height: 1024/689 07:59:42 INFO - PROCESS | 2465 | __metrics 07:59:42 INFO - PROCESS | 2465 | 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" 07:59:42 INFO - PROCESS | 2465 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:59:43 INFO - TEST-INFO | 2465: exit 0 07:59:43 INFO - Browser initialized. 07:59:43 INFO - Running cycle 1/1 for dromaeo_css test... 07:59:43 INFO - TEST-INFO | started process 2467 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/tmpvzCry9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:55 INFO - PROCESS | 2467 | RSS: Main: 214999040 07:59:55 INFO - PROCESS | 2467 | 08:02:59 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:62309/tests/dromaeo/cssquery-dojo.html (next: http://localhost:62309/tests/dromaeo/cssquery-ext.html) 08:03:01 INFO - PROCESS | 2467 | RSS: Main: 402046976 08:03:01 INFO - PROCESS | 2467 | 08:04:45 INFO - PROCESS | 2467 | ************************* 08:04:45 INFO - PROCESS | 2467 | A coding exception was thrown and uncaught in a Task. 08:04:45 INFO - PROCESS | 2467 | 08:04:45 ERROR - PROCESS | 2467 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:04:45 INFO - PROCESS | 2467 | Full stack: 08:04:45 INFO - PROCESS | 2467 | ************************* 08:06:04 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:62309/tests/dromaeo/cssquery-ext.html (next: http://localhost:62309/tests/dromaeo/cssquery-jquery.html) 08:06:05 INFO - PROCESS | 2467 | RSS: Main: 352190464 08:06:05 INFO - PROCESS | 2467 | 08:09:08 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:62309/tests/dromaeo/cssquery-jquery.html (next: http://localhost:62309/tests/dromaeo/cssquery-mootools.html) 08:09:08 INFO - PROCESS | 2467 | RSS: Main: 328736768 08:09:08 INFO - PROCESS | 2467 | 08:12:11 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:62309/tests/dromaeo/cssquery-mootools.html (next: http://localhost:62309/tests/dromaeo/cssquery-prototype.html) 08:12:11 INFO - PROCESS | 2467 | RSS: Main: 318115840 08:12:11 INFO - PROCESS | 2467 | 08:15:15 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:62309/tests/dromaeo/cssquery-prototype.html (next: http://localhost:62309/tests/dromaeo/cssquery-yui.html) 08:15:15 INFO - PROCESS | 2467 | RSS: Main: 325439488 08:15:15 INFO - PROCESS | 2467 | 08:18:19 INFO - PROCESS | 2467 | Cycle 1(1): loaded http://localhost:62309/tests/dromaeo/cssquery-yui.html (next: http://localhost:62309/tests/dromaeo/cssquery-dojo.html) 08:18:19 INFO - PROCESS | 2467 | RSS: Main: 470974464 08:18:19 INFO - PROCESS | 2467 | 08:18:19 INFO - PROCESS | 2467 | __start_tp_report 08:18:19 INFO - PROCESS | 2467 | _x_x_mozilla_page_load 08:18:19 INFO - PROCESS | 2467 | _x_x_mozilla_page_load_details 08:18:19 INFO - PROCESS | 2467 | |i|pagename|runs| 08:18:19 INFO - PROCESS | 2467 | |0;dojo.html;2734.7401996810304;3382.8139452330142;3401.982990085049;3422.7946323220626;3448.4654878493825;4893.510648935105;6001.519878409727;6027.487663548603;6046.395360463951;6052.667103309316;5995.6102853314505;6057.575969682124;6057.848553786158;6075.787347442841;6085.934961381763;5388.164834450657;5397.595180361469;5435.864103397427;5514.834554963358;5517.5585953123855;5298.708571028592;5316.893662126755;5509.669419834802;5516.475934786189;5516.724163791814;5384.946150538483;5399.352077750656;5417.160340147283;5430.511253987141;5454.59090568207;5445.047116754552;5445.727713614323;5455.0453670607485;5458.399576046631;5468.99999999998;5294.549963253128;5397.7031263280505;5403.972980135074;5422.40353561108;5426.728663566806;6087.817365479043;6089.665068421235;6090.42140996609;6094.055421409645;6094.39056094387;6289.37106289372;6304.684765761694;6310.936890631081;6313.116163737081;6322.178116844827;6322.683865806737;6324.3991820776955;6340.3659634036685;6342.619442833398;6352.269489008777;6059.484943779784;6118.20463339763;6138.386161383826;6153.938460615382;6156.292026416974;6561.507886908501;6571.67141642916;6580.4406625436895;6583.736650533973;6594.934050659432;6209.844753881099;6247.718852651642;6251.343608921089;6265.091561723524;6310.684465776784;6455.515836312202;6470.579412338183;6473.546851720334;6481.675916204171;6489.1888513935755;6366.458850997625;6379.298277189506;6392.20097487814;6393.944999075194;6400.327965563549;6232.0963460298;6284.277308109535;6307.873842523124;6399.424051835357;6405.583637063576;5104.540591346797;5127.820526281562;5185.196294574347;5192.091384007784;5214.7914083437;4589.885252868705;4593.448786145684;4609.078184363141;4609.2394754865745;4625.398698169217;5861.824145275648;6076.5442591805795;6107.29766076898;6111.54163437735;6128.387161283836;6325.873482530324;6327.114204011442;6331.905021424683;6345.36546345371;6369.172007638977;6032.517398608188;6061.151438798572;6068.939310606837;6076.058210977306;6084.087386891913;5647.209390685307;5658.801941932013;5663.32040155184;5675.687837168913;5681.261436013375;5424;6365.077063825626;6375.904361434675;6502.642354670538;6658.766943157063;6285.025820997753;6303.212098487689;6305.369463053658;6313.621182729051;6315.147455093687;5938.584299099021;6361.886669832853;6564.6389448578875;6729.024291477611;6741.393274605309;6312.7159277833525;6381.840453988688;6398.584092034003;6401.743930242738;6405.103285539935;6320.1467801848;6438.742450301936;6454.870902581828;6458.22501299847;6474.125992991075;5102.413222479462;6194.690265486798;6240.968795155995;6266.122742816101;6301.275353334425;6310.558260921692;6318.6840657965995;6319.557630965788;6322.683865806784;6328.272248691275;6297.118403423433;6308.936910631019;6316.463100636497;6316.810495685137;6323.936760632335;6173.84565385869;6200.968995154995;6235.719392627433;6250.968745156245;6335.429811317003;6210.4100110489435;6213.875722485615;6281;6288.245410550763;6289.7484100635465 08:18:19 INFO - PROCESS | 2467 | |1;ext.html;688.7313947560451;736.1828370508738;810.7932477218309;877.4472082587969;891.8706787515806;27935.441291174164;40023.79988100059;40849.79575102128;40867.38698919515;41028.79485602575;40158.598414015854;40359.596404035954;40392;40413.797931010304;40446.79776601113;7293.7082516699265;8794.604242809057;8960.820783584324;8969.058248883872;8974.057723938959;7380.261973802631;7422;7454.739084132057;7461.813454663623;7463.402927765793;10839.078678312353;11028.669139925814;11157.442127893613;11215.327080375162;11224.66326010221;10984.560617575287;11030.172737044753;11030.834537481944;11042.171837112248;11045.83431248532;7256.383207427375;7439.330460258549;10907.618233361794;10988.890111098866;10988.956049175316;27820.443591128267;28003.71996280052;28074.578881316796;38601.42097868534;39149.41275880864;3686.7972261525606;3688.22547265072;3871.6902647788393;3911.0808959894403;3918.922296368493;24696.753032469624;25929;26280.86859565709;26540.07109751169;26552.867235663893;3066.9079927602206;3072.2933725243097;3106.689331066898;3110.9533356999664;3141.748660107186;355191;357017.2149139264;357465;357749;358065;45846.31230531545;48042.27936580954;53645;54954;55100.448995509534;49753.25370119451;50127.997440051724;50205.74897125491;50208.497915021115;50247.748761255956;14827.92586037063;14895;14897.925510372379;14907;14916.328765205591;10624.628138015132;12786.041046921519;12822.487100515875;12851;12877.806832897513;10499.317544359592;10706.197035222389;10732.570697172026;11952.34262115592;12218.877811221952;4771.196148096378;4865.70805751656;5487.859734703469;5705.144228365778;5712.742926568314;1111.5887121765;1129.5764088466824;1131.7793030359167;1157.5935238685038;1167.3054532553117;26924.461510769674;26952.191434257005;27263.045793397137;27334.45331093367;27495.587566186525;1150.7871043856912;1245.5578269714301;1271.4596296573918;1289.2844471318322;1294.7604693131611;11351.545938162546;13172.209667419986;13936;14124.081934674214;14255.50105746294;488587;490111;490142;491794;492568;57418.425815741306;57798.13302800462;57809.71095144498;57907.420925790204;57949;1427.5931359562683;1466.8313143988578;1469.7207530568944;1471.2055490035261;1475.9262036898112;25207.747922521274;26022.73977260203;26265.343366415993;26713.19860404191;27206.319842003315;46642.067158657315;46668.299975499714;46727.29909051299;46728.29907551457;46735.831604210165;454617;458263;458540;458917;459216;32612;33076;33183;33288.667113328556;33294;44346.778266108464;44493.77753111214;45328.54671453243;45758.54241457543;46092.53907460882;32794.67205327916;35492.46761298531;36275.63724362723;36432;36888;30719.924802632693;33268;36404.27191456103;36760.26479470449;37607.811960940024;35387.82306088453;35625.287494250486;36783.44824827576;36798.63201368059;37217.25565488729;22459;27288.538494889377;30991.690083099784;31055.913043043383;31106.222344440666;24011.75988240095;24067;24076.277711668678;24659.876700616383;24782.628260575744 08:18:19 INFO - PROCESS | 2467 | |2;jquery.html;394.15060544526517;408.44859439756334;421.80596925414306;430.78891343241816;446.6002927379995;12759.744805103905;14551.490697825579;19218.039098045112;20720.89639551802;21559.245426410078;18488.72266915994;21110.788892111075;22082.668759968612;22500;23159.84200789958;6412.102305677209;6439.935600643992;6658.500612454061;6700.463962882982;6748.358905903956;4134.834606615732;4400.691951563392;6626.93373066268;6627.536072474929;6692.531522793406;4363.607275345218;7620.885686714703;7639.083310002808;7640.7325743598985;7660.195679453661;7394.334509894135;7592.620368981528;7611.429142814283;7614.619269036526;7690.500117492345;7258.947452619341;7268.745593904241;7453;7483.625818709097;7487.513311634781;27122.050728224418;27136.592951105747;27212.31969200766;27403.31491712703;27524.724752752616;2686.130804192845;3297.8351082445784;3389.5085212644276;3498.4577390504514;3543.433050711874;15052.473163439226;15292;15397.769033464507;15505.534833955;15509;1991.3415590187117;2028.3914825552276;2035.185925629745;2095.21429463951;2095.256184054669;92607;118157.29980565533;118880;121517;122676.38661806723;20851.58296834055;21194.364169074954;21340.253091141734;21435.67846482304;21474.141034358763;34601.82699086489;35017.64982350144;35394;35428.29143417117;35527.822360888546;10699.983501567338;10711.94644026775;10787.137029037658;10927.125829933586;11079.224454288284;8890.86663700045;8899.243564296978;8923.196912277795;9054.592543335566;9077.636894524278;9949.850752238723;10238.692839214686;10349.430781307101;10363.533640986174;10388.636397726195;3991.3214753491975;4076.7553946763287;4106.938395924063;4110.608747783091;4111.6299533042165;1025.3284098915221;1032.210359075293;1080.3524624946863;1096.5230124895695;1131.5869707556847;22766.544669106526;23179.884100579387;23192.18827341035;23212.535749284918;23336.949837257365;1015.8476228565775;1019.3017782818793;1085.664632502027;1088.4394536813547;1136.9488373023069;10935.56257749697;11137.944310278397;12089.000363287143;12118.81821772674;12177.634670959886;726526;754536;756845;767206.1639691878;790978;77329;121552;122213;126464;127245;1222.8654847966716;1244.975100498003;1261.394530625305;1264.5953294945714;1264.791309433933;19544.413667589994;19548.924809135635;20074.39776806698;20100.497487562927;20147.69778453295;48230.75884620695;52992;53977;54573.72713136409;54717;61232.775344493755;62799;72209;74199;74522;11510.964013238849;11901.226420282654;12133.69665758363;12248;12417.875821241672;13104;13139.408726607135;13143.868561314264;13311.33443327849;13326.466941322238;11157.27477713946;11183.664490065312;11259.099272058053;11474.541018359507;11665.825012624988;10385.896141038795;10851.565937362417;11319;11425;11544.365059921785;11298.265612735146;11527.250728702607;11667.066634669376;11785.292882427082;11822.881771182178;11038.44807759625;11327.943360283145;11373.886261137282;11450.370229637118;11669;10884.836727449254;11161;11255.099592032453;11356.602518911799;11364.715882103013 08:18:19 INFO - PROCESS | 2467 | |3;mootools.html;1360.476216656587;1544.7914531538247;1561.5393458929614;1571.2458020150327;1583.8020247469067;10595.682129536117;11559.826602600946;11575.42122893854;11579.768404631903;11582.53669853206;10810.783784324329;11229.887701123007;11447.370394628291;11452.541898324058;11459.770804583903;2418.854868707874;2471.8393304435244;2472.8006916645413;2473.950520989579;2474.05985725425;2341.66045923341;2373.8694371809543;2379.2505360811374;2380.773826486481;2381.226101517005;2396.5206958608346;2416.6858308419883;2422.709274887016;2426.8179886508583;2429.7327293997646;2028.4421784009514;2371.2886134159685;2376.287113865842;2385.689860318165;2397.85612863227;2321.6749655048307;2326.7324257710243;2397.832151749378;2403.134871446278;2406.1217655555597;10543.578256869716;10655.733606659818;10669.359838409642;10680.412577308245;10693.198010149192;5790.247267855194;6018.15745795589;6024.8493787655225;6029.577929544934;6031.396860313977;3537.876174333912;3578.284343131358;3631.3100510902846;3679.889603311905;3707.610700876396;1175.864775550814;1185.2651356159236;1202.1945296651265;1248.950041998319;1266.8986481081492;13764.449422023206;14070.22613756243;14427.855721442756;15312.464063757716;15469.690606187925;4027.0692149546967;4235.597618226325;4357.106793107406;4367.75977321244;4416.271315232951;11745.236559623598;11770;11789.233699809485;11798;11818.409079545989;5900.1739756434135;5909.586328957018;5913.852153696192;5913.940860591425;5923.318818335861;5098.260752190911;5263.315768950012;5277.445868183862;5348.1442969124755;5376.811811586654;3809.4285857121654;3849.40334248192;3900.063984643665;3924.1955399143108;3944.3294639911283;1035.1511760356436;1035.2597892506894;1039.6413237433073;1046.2048842879315;1053.4995876958537;890.9777255568663;916.6241840845355;924.1497822003772;937.7702462896498;965.2085290062082;5859.740155866509;6542.585434201493;6566.080748695186;6612.471002319803;6678.065070890079;926.1803304075942;967.709687093869;969.413504829582;974.9756256093655;1011.9392836429838;3215.9917543755196;3941.586133455946;4174.436451079066;4205.222033923734;4427.800748966304;13312;13801.723965520834;13807.378667959965;13810.033297669268;13866.376013079436;13400.664983375298;13626;13757.037007409384;13757.38091785872;13767.655808604664;8656.350773692124;10085.142762865238;10136;10230.948845255725;10242.129418999319;5802.274715660543;5868.882622347443;6767.661616919233;6994.405475534637;7017.052697885924;11707.824382634437;11977.401129943642;12132.75734485323;12148.392580371123;12151.939240303742;12280.447379867748;12752.6811829705;12905.612831615066;12931.094823362275;12937.935310323388;8229.95885020571;8465.449745766506;8474.576271186294;8503.319734421108;8523.318134549098;10108.797824043624;10314.638987635397;10416.11463025621;10434.321769084985;10435.895641043493;9046.819063618559;9135.497547634677;9290.442573445614;9371.578278977326;9491.335606507479;9167.12912273333;9174.990751017516;9181.449113053239;9260.981292058003;9342.719718408458;7884.763457096296;8041.155678653658;8049.678012879419;8050.718224862102;8061.798455038671;5797.884042319214;5803.245578074992;5878.2064421302575;6027.728752206249;6088.543359247986;5788.9131663024245;5886.940350736909;5938.435848594377;6161.199044124235;6269.905951410824 08:18:19 INFO - PROCESS | 2467 | |4;prototype.html;378.72353182177017;379.9354109801333;384.1816929939229;388.3785942492013;391.66247265588;4372.726182385158;4560.30615201686;5105.668131571445;5160.329157209562;5299.178627312773;4602.918314196161;4899;5003.3488948646955;5099;5155.370760911934;3244.6430892601793;3551.5027896094566;3784.6942804732325;3992.9800350998203;4008.418779277003;3568.4468907319406;3861.2470568239205;4035.8183881725245;4075.2257071156387;4078.2047500737367;4042.8382864685523;4045.9595404045876;4049.6107296694945;4059.451973983504;4074.7351422157612;3413.1808365992106;3572.982135089308;3749.550053993511;3959.75300253792;4029.657479114279;3327.45097058985;3353.0779035765117;3540.522029526007;3552.715782737375;3562.786232826039;3997.520297564282;4034.838606455738;4761.547652972962;4789.592884604813;4935.556899334816;4068.7355321903983;4364.908772806798;4508.977455112737;4509.954900450986;4645.279981602857;4965.155923493015;5346.251524786533;5395.595330350239;5400.78396864125;5450.427705090948;3514.6309637487952;3711.4247291669835;3978.5822488638564;3983.64147226751;3983.8605648802154;4791.9520804791855;4911.9754401227765;5566.2207290979295;5694.999999999958;5700.8859822803315;4102.466679331667;4309.1381723655395;4366.323219900921;4795.784189711471;4878.536539028786;4365.410669559632;4729.69256998294;4943.2585112233455;4967.4784147664695;5020.698758074527;4215.641670458045;4571.000374672162;4637.634806248838;4959.504049595012;5121.897562048738;4806.615470762331;5154.845354639367;5259.579233661298;5456;5490.709683224439;1470.5441313192944;1507.974577287433;1670.8663306935416;1684.6546457976085;1694.8051623605575;1274.9235045897276;1303.419978109732;1353.82893796865;1367.3983447283163;1385.009718051598;4801.663883528119;4922.75386230687;5060.15428274514;5086.5422112009355;5101.464346243591;5060.696358218519;5072.5688316493515;5591.664500129924;5608.859778505488;5626.774929002794;4737.502562230985;4842.661013729075;5032.521910418504;5080.441151473335;5087.23691446286;2375.382400575863;2877.6259086318646;2923.766098712098;2926.780491463106;2931.6042334285025;4868.14807408702;5071.492850714899;5225.458489745458;5491.752871120809;5579.079451890392;4943.975280123576;5037.596992240685;5707.800226992035;5779.590041875314;5791.739371728282;4971.90056198874;5285.546474719406;5383.623146379716;5733.684647344436;5792.594518383673;4880.901797095625;5396.244525766318;5556.083246264483;5589.546717853469;5648.943510565006;5232.5552328052545;5497.367802702581;5542.5565954722715;5554.333919718477;5560.304961879765;5112.079825631274;5176;5378.569714422759;5640.746166422438;5826.388229235869;4456.487503936959;4492.955070449254;4504.121696269196;4567.748773817339;4568.680192386501;4931.753412329441;5109.131447653834;5588.944110558842;5600.635958662674;5615.686744820576;4893.266010098514;5196.142636464941;5203.453637368022;5412.809181979958;5440.972795135999;4782.736949467812;4965.343541205582;5205.401378841481;5405.324379422031;5438.564914806885;4242.278812601803;4396.890077747954;4669.859904202879;4933.654644174873;5209.76556054986;4354.303311470149;4966.900661986668;5171.301874247079;5475.589330800126;5484.588655850907;4240.851570195028;4744.430668319824;5339.332583427072;5364.436734142859;5417.702026388586 08:18:19 INFO - PROCESS | 2467 | |5;yui.html;715.8997740316356;727.1710250314638;730.9707611695533;765.7894079128239;838.2790799912075;14908.478203262874;15516;15628.055650689173;15748.76376854348;15897.52307430776;14131.434742610283;14275.2862356882;14495.42018319266;14530.782038269408;14675.486357977474;904.3398319226985;922.2253307221932;926.5691453474133;930.702175303903;932.0213775535694;918.7243826851918;922.4511415707643;957.8132264208482;965.946872921989;966.9081437263484;998.1316254858283;1002.6641075239803;1003.7490627343165;1005.708344580071;1005.8440941654055;996.9551370188286;997.5710444508858;999.4752754803714;1000.1898462245605;1002.3484734922285;745.6495447139836;747.3348719639471;747.8429529798749;750.4146765522901;751.8458715963214;15280.38878444872;15679;15807.367705291774;16103.516894493185;16390;13888.375023123883;14186.639012010814;14212.360443780055;14239.501617443444;14249.928750356286;11565.884341156649;11745.177837551375;11909.583164589198;12079.516819327217;12373.381330933418;3607.549056367954;3656.4880916671686;3706.629337066299;3735.962640373589;3852.114013776847;108190.91809081887;109623;110389.34415983767;112916.30625540705;113015.43492282568;10512.632057877938;10702.678919632424;10721;10752.946235268773;11281.492332845042;22210.66683999741;22421.66367504489;22432.66351004736;22434.102635894382;22511;7637.618119094023;7732.6133693315105;7742.961285193538;7862.488938219112;7895.210478952059;4306.4832220133785;4308.5045219799495;4357.54245804186;4375.431193944767;4427.424434823452;3464.566929133858;3528.770629909048;3553.218291975761;3563.1626567756557;3570.339487194877;634.7651368993502;639.6993413095837;644.6196743921109;644.9967750161313;645.8159424563977;661.1669296686114;667.9131712877295;670.5440300595642;683.7435961514432;729.9160596531467;9563.426194428357;9781.951090244645;10327.638532651321;10329.32859364154;10508.474576271155;655.6918248423234;679.78246960973;691.8616276744672;701.6604974059451;721.4516967105038;4644.60520855731;4898.853034408973;4904.950950490521;4912.091263116335;4923.187674033816;99812.00375992585;103663.11537288476;105291;105395.41906871404;107039;66451.66774166099;72322.63838680879;90783;92420.53789731009;94924.52537737267;82519;83636.58181709175;83705;84770;85494.57252713821;9408.482533460725;9421.528923553658;9423.10480504351;9428.858567121362;9457.43255404678;44667.55332446634;45735.771321143184;51161.46515604538;51793.115516335674;53391.73304133455;50008.499915000386;63358.366416335244;64130.35869641244;64309.03536446863;64665.67667161634;12945.96432285396;12960.724476854803;12998.675033124247;13111.934440327737;13356.296018969175;14587.843297652606;14648.85351146475;14667.706645867236;14912.328945197276;15104.169270690218;13644.863551364358;14003.649908752363;14006.78989815174;14094.013419060977;14292.571222863331;13629.318534073454;13758.243296618783;14073.155610663393;14250.928745356621;14589.854101459274;12598.496060157857;13032.850414356346;13614.115082519604;13639.181649101085;13902.51341203053;10755.516001780095;10999.670009899715;11509.96410323075;11631.53473861036;11674.94162529182;8123.038541119892;8898.644054237759;10347.84478232812;11211.439428028729;11874.287542747463 08:18:19 INFO - PROCESS | 2467 | __end_tp_report 08:18:19 INFO - PROCESS | 2467 | __start_cc_report 08:18:19 INFO - PROCESS | 2467 | _x_x_mozilla_cycle_collect,1844 08:18:19 INFO - PROCESS | 2467 | __end_cc_report 08:18:19 INFO - PROCESS | 2467 | __startTimestamp1490282299301__endTimestamp 08:18:19 INFO - PROCESS | 2467 | 08:18:19 INFO - PROCESS | 2467 | ------- Summary: start ------- 08:18:19 INFO - PROCESS | 2467 | Number of tests: 6 08:18:19 INFO - PROCESS | 2467 | 08:18:19 INFO - PROCESS | 2467 | [#0] dojo.html Cycles:165 Average:5941.10 Median:6210.41 stddev:671.99 (10.8%) stddev-sans-first:625.20 08:18:19 INFO - PROCESS | 2467 | Values: 2734.7 3382.8 3402.0 3422.8 3448.5 4893.5 6001.5 6027.5 6046.4 6052.7 5995.6 6057.6 6057.8 6075.8 6085.9 5388.2 5397.6 5435.9 5514.8 5517.6 5298.7 5316.9 5509.7 5516.5 5516.7 5384.9 5399.4 5417.2 5430.5 5454.6 5445.0 5445.7 5455.0 5458.4 5469.0 5294.5 5397.7 5404.0 5422.4 5426.7 6087.8 6089.7 6090.4 6094.1 6094.4 6289.4 6304.7 6310.9 6313.1 6322.2 6322.7 6324.4 6340.4 6342.6 6352.3 6059.5 6118.2 6138.4 6153.9 6156.3 6561.5 6571.7 6580.4 6583.7 6594.9 6209.8 6247.7 6251.3 6265.1 6310.7 6455.5 6470.6 6473.5 6481.7 6489.2 6366.5 6379.3 6392.2 6393.9 6400.3 6232.1 6284.3 6307.9 6399.4 6405.6 5104.5 5127.8 5185.2 5192.1 5214.8 4589.9 4593.4 4609.1 4609.2 4625.4 5861.8 6076.5 6107.3 6111.5 6128.4 6325.9 6327.1 6331.9 6345.4 6369.2 6032.5 6061.2 6068.9 6076.1 6084.1 5647.2 5658.8 5663.3 5675.7 5681.3 5424.0 6365.1 6375.9 6502.6 6658.8 6285.0 6303.2 6305.4 6313.6 6315.1 5938.6 6361.9 6564.6 6729.0 6741.4 6312.7 6381.8 6398.6 6401.7 6405.1 6320.1 6438.7 6454.9 6458.2 6474.1 5102.4 6194.7 6241.0 6266.1 6301.3 6310.6 6318.7 6319.6 6322.7 6328.3 6297.1 6308.9 6316.5 6316.8 6323.9 6173.8 6201.0 6235.7 6251.0 6335.4 6210.4 6213.9 6281.0 6288.2 6289.7 08:18:19 INFO - PROCESS | 2467 | 08:18:19 INFO - PROCESS | 2467 | [#1] ext.html Cycles:180 Average:57126.61 Median:35440.15 stddev:116636.49 (329.1%) stddev-sans-first:116886.71 08:18:19 INFO - PROCESS | 2467 | Values: 688.7 736.2 810.8 877.4 891.9 27935.4 40023.8 40849.8 40867.4 41028.8 40158.6 40359.6 40392.0 40413.8 40446.8 7293.7 8794.6 8960.8 8969.1 8974.1 7380.3 7422.0 7454.7 7461.8 7463.4 10839.1 11028.7 11157.4 11215.3 11224.7 10984.6 11030.2 11030.8 11042.2 11045.8 7256.4 7439.3 10907.6 10988.9 10989.0 27820.4 28003.7 28074.6 38601.4 39149.4 3686.8 3688.2 3871.7 3911.1 3918.9 24696.8 25929.0 26280.9 26540.1 26552.9 3066.9 3072.3 3106.7 3111.0 3141.7 355191.0 357017.2 357465.0 357749.0 358065.0 45846.3 48042.3 53645.0 54954.0 55100.4 49753.3 50128.0 50205.7 50208.5 50247.7 14827.9 14895.0 14897.9 14907.0 14916.3 10624.6 12786.0 12822.5 12851.0 12877.8 10499.3 10706.2 10732.6 11952.3 12218.9 4771.2 4865.7 5487.9 5705.1 5712.7 1111.6 1129.6 1131.8 1157.6 1167.3 26924.5 26952.2 27263.0 27334.5 27495.6 1150.8 1245.6 1271.5 1289.3 1294.8 11351.5 13172.2 13936.0 14124.1 14255.5 488587.0 490111.0 490142.0 491794.0 492568.0 57418.4 57798.1 57809.7 57907.4 57949.0 1427.6 1466.8 1469.7 1471.2 1475.9 25207.7 26022.7 26265.3 26713.2 27206.3 46642.1 46668.3 46727.3 46728.3 46735.8 454617.0 458263.0 458540.0 458917.0 459216.0 32612.0 33076.0 33183.0 33288.7 33294.0 44346.8 44493.8 45328.5 45758.5 46092.5 32794.7 35492.5 36275.6 36432.0 36888.0 30719.9 33268.0 36404.3 36760.3 37607.8 35387.8 35625.3 36783.4 36798.6 37217.3 22459.0 27288.5 30991.7 31055.9 31106.2 24011.8 24067.0 24076.3 24659.9 24782.6 08:18:19 INFO - PROCESS | 2467 | 08:18:19 INFO - PROCESS | 2467 | [#2] jquery.html Cycles:180 Average:40647.22 Median:11473.40 stddev:124835.85 (1088.0%) stddev-sans-first:125149.45 08:18:19 INFO - PROCESS | 2467 | Values: 394.2 408.4 421.8 430.8 446.6 12759.7 14551.5 19218.0 20720.9 21559.2 18488.7 21110.8 22082.7 22500.0 23159.8 6412.1 6439.9 6658.5 6700.5 6748.4 4134.8 4400.7 6626.9 6627.5 6692.5 4363.6 7620.9 7639.1 7640.7 7660.2 7394.3 7592.6 7611.4 7614.6 7690.5 7258.9 7268.7 7453.0 7483.6 7487.5 27122.1 27136.6 27212.3 27403.3 27524.7 2686.1 3297.8 3389.5 3498.5 3543.4 15052.5 15292.0 15397.8 15505.5 15509.0 1991.3 2028.4 2035.2 2095.2 2095.3 92607.0 118157.3 118880.0 121517.0 122676.4 20851.6 21194.4 21340.3 21435.7 21474.1 34601.8 35017.6 35394.0 35428.3 35527.8 10700.0 10711.9 10787.1 10927.1 11079.2 8890.9 8899.2 8923.2 9054.6 9077.6 9949.9 10238.7 10349.4 10363.5 10388.6 3991.3 4076.8 4106.9 4110.6 4111.6 1025.3 1032.2 1080.4 1096.5 1131.6 22766.5 23179.9 23192.2 23212.5 23336.9 1015.8 1019.3 1085.7 1088.4 1136.9 10935.6 11137.9 12089.0 12118.8 12177.6 726526.0 754536.0 756845.0 767206.2 790978.0 77329.0 121552.0 122213.0 126464.0 127245.0 1222.9 1245.0 1261.4 1264.6 1264.8 19544.4 19548.9 20074.4 20100.5 20147.7 48230.8 52992.0 53977.0 54573.7 54717.0 61232.8 62799.0 72209.0 74199.0 74522.0 11511.0 11901.2 12133.7 12248.0 12417.9 13104.0 13139.4 13143.9 13311.3 13326.5 11157.3 11183.7 11259.1 11474.5 11665.8 10385.9 10851.6 11319.0 11425.0 11544.4 11298.3 11527.3 11667.1 11785.3 11822.9 11038.4 11327.9 11373.9 11450.4 11669.0 10884.8 11161.0 11255.1 11356.6 11364.7 08:18:19 INFO - PROCESS | 2467 | 08:18:19 INFO - PROCESS | 2467 | [#3] mootools.html Cycles:180 Average:6735.08 Median:2450.79 stddev:4213.55 (171.9%) stddev-sans-first:4206.02 08:18:19 INFO - PROCESS | 2467 | Values: 1360.5 1544.8 1561.5 1571.2 1583.8 10595.7 11559.8 11575.4 11579.8 11582.5 10810.8 11229.9 11447.4 11452.5 11459.8 2418.9 2471.8 2472.8 2474.0 2474.1 2341.7 2373.9 2379.3 2380.8 2381.2 2396.5 2416.7 2422.7 2426.8 2429.7 2028.4 2371.3 2376.3 2385.7 2397.9 2321.7 2326.7 2397.8 2403.1 2406.1 10543.6 10655.7 10669.4 10680.4 10693.2 5790.2 6018.2 6024.8 6029.6 6031.4 3537.9 3578.3 3631.3 3679.9 3707.6 1175.9 1185.3 1202.2 1249.0 1266.9 13764.4 14070.2 14427.9 15312.5 15469.7 4027.1 4235.6 4357.1 4367.8 4416.3 11745.2 11770.0 11789.2 11798.0 11818.4 5900.2 5909.6 5913.9 5913.9 5923.3 5098.3 5263.3 5277.4 5348.1 5376.8 3809.4 3849.4 3900.1 3924.2 3944.3 1035.2 1035.3 1039.6 1046.2 1053.5 891.0 916.6 924.1 937.8 965.2 5859.7 6542.6 6566.1 6612.5 6678.1 926.2 967.7 969.4 975.0 1011.9 3216.0 3941.6 4174.4 4205.2 4427.8 13312.0 13801.7 13807.4 13810.0 13866.4 13400.7 13626.0 13757.0 13757.4 13767.7 8656.4 10085.1 10136.0 10230.9 10242.1 5802.3 5868.9 6767.7 6994.4 7017.1 11707.8 11977.4 12132.8 12148.4 12151.9 12280.4 12752.7 12905.6 12931.1 12937.9 8230.0 8465.4 8474.6 8503.3 8523.3 10108.8 10314.6 10416.1 10434.3 10435.9 9046.8 9135.5 9290.4 9371.6 9491.3 9167.1 9175.0 9181.4 9261.0 9342.7 7884.8 8041.2 8049.7 8050.7 8061.8 5797.9 5803.2 5878.2 6027.7 6088.5 5788.9 5886.9 5938.4 6161.2 6269.9 08:18:19 INFO - PROCESS | 2467 | 08:18:19 INFO - PROCESS | 2467 | [#4] prototype.html Cycles:180 Average:4455.51 Median:4887.08 stddev:1236.87 (25.3%) stddev-sans-first:1201.89 08:18:19 INFO - PROCESS | 2467 | Values: 378.7 379.9 384.2 388.4 391.7 4372.7 4560.3 5105.7 5160.3 5299.2 4602.9 4899.0 5003.3 5099.0 5155.4 3244.6 3551.5 3784.7 3993.0 4008.4 3568.4 3861.2 4035.8 4075.2 4078.2 4042.8 4046.0 4049.6 4059.5 4074.7 3413.2 3573.0 3749.6 3959.8 4029.7 3327.5 3353.1 3540.5 3552.7 3562.8 3997.5 4034.8 4761.5 4789.6 4935.6 4068.7 4364.9 4509.0 4510.0 4645.3 4965.2 5346.3 5395.6 5400.8 5450.4 3514.6 3711.4 3978.6 3983.6 3983.9 4792.0 4912.0 5566.2 5695.0 5700.9 4102.5 4309.1 4366.3 4795.8 4878.5 4365.4 4729.7 4943.3 4967.5 5020.7 4215.6 4571.0 4637.6 4959.5 5121.9 4806.6 5154.8 5259.6 5456.0 5490.7 1470.5 1508.0 1670.9 1684.7 1694.8 1274.9 1303.4 1353.8 1367.4 1385.0 4801.7 4922.8 5060.2 5086.5 5101.5 5060.7 5072.6 5591.7 5608.9 5626.8 4737.5 4842.7 5032.5 5080.4 5087.2 2375.4 2877.6 2923.8 2926.8 2931.6 4868.1 5071.5 5225.5 5491.8 5579.1 4944.0 5037.6 5707.8 5779.6 5791.7 4971.9 5285.5 5383.6 5733.7 5792.6 4880.9 5396.2 5556.1 5589.5 5648.9 5232.6 5497.4 5542.6 5554.3 5560.3 5112.1 5176.0 5378.6 5640.7 5826.4 4456.5 4493.0 4504.1 4567.7 4568.7 4931.8 5109.1 5588.9 5600.6 5615.7 4893.3 5196.1 5203.5 5412.8 5441.0 4782.7 4965.3 5205.4 5405.3 5438.6 4242.3 4396.9 4669.9 4933.7 5209.8 4354.3 4966.9 5171.3 5475.6 5484.6 4240.9 4744.4 5339.3 5364.4 5417.7 08:18:19 INFO - PROCESS | 2467 | 08:18:19 INFO - PROCESS | 2467 | [#5] yui.html Cycles:180 Average:20557.27 Median:3588.94 stddev:29669.35 (826.7%) stddev-sans-first:29715.17 08:18:19 INFO - PROCESS | 2467 | Values: 715.9 727.2 731.0 765.8 838.3 14908.5 15516.0 15628.1 15748.8 15897.5 14131.4 14275.3 14495.4 14530.8 14675.5 904.3 922.2 926.6 930.7 932.0 918.7 922.5 957.8 965.9 966.9 998.1 1002.7 1003.7 1005.7 1005.8 997.0 997.6 999.5 1000.2 1002.3 745.6 747.3 747.8 750.4 751.8 15280.4 15679.0 15807.4 16103.5 16390.0 13888.4 14186.6 14212.4 14239.5 14249.9 11565.9 11745.2 11909.6 12079.5 12373.4 3607.5 3656.5 3706.6 3736.0 3852.1 108190.9 109623.0 110389.3 112916.3 113015.4 10512.6 10702.7 10721.0 10752.9 11281.5 22210.7 22421.7 22432.7 22434.1 22511.0 7637.6 7732.6 7743.0 7862.5 7895.2 4306.5 4308.5 4357.5 4375.4 4427.4 3464.6 3528.8 3553.2 3563.2 3570.3 634.8 639.7 644.6 645.0 645.8 661.2 667.9 670.5 683.7 729.9 9563.4 9782.0 10327.6 10329.3 10508.5 655.7 679.8 691.9 701.7 721.5 4644.6 4898.9 4905.0 4912.1 4923.2 99812.0 103663.1 105291.0 105395.4 107039.0 66451.7 72322.6 90783.0 92420.5 94924.5 82519.0 83636.6 83705.0 84770.0 85494.6 9408.5 9421.5 9423.1 9428.9 9457.4 44667.6 45735.8 51161.5 51793.1 53391.7 50008.5 63358.4 64130.4 64309.0 64665.7 12946.0 12960.7 12998.7 13111.9 13356.3 14587.8 14648.9 14667.7 14912.3 15104.2 13644.9 14003.6 14006.8 14094.0 14292.6 13629.3 13758.2 14073.2 14250.9 14589.9 12598.5 13032.9 13614.1 13639.2 13902.5 10755.5 10999.7 11510.0 11631.5 11674.9 8123.0 8898.6 10347.8 11211.4 11874.3 08:18:19 INFO - PROCESS | 2467 | -------- Summary: end -------- 08:18:19 INFO - PROCESS | 2467 | 08:18:19 INFO - TEST-INFO | 2467: exit 0 08:18:20 INFO - TEST-OK | dromaeo_css | took 1119420ms 08:18:20 INFO - TEST-START | kraken 08:18:20 INFO - operating with platform_type : mac_ 08:18:20 INFO - Initialising browser for kraken test... 08:18:20 INFO - TEST-INFO | started process 2469 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/tmp9VgFNd/profile http://localhost:62309/getInfo.html) 08:18:22 INFO - PROCESS | 2469 | __metrics Screen width/height:1600/1200 08:18:22 INFO - PROCESS | 2469 | colorDepth:24 08:18:22 INFO - PROCESS | 2469 | Browser inner width/height: 1024/689 08:18:22 INFO - PROCESS | 2469 | __metrics 08:18:22 INFO - PROCESS | 2469 | 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:18:22 INFO - PROCESS | 2469 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:18:23 INFO - TEST-INFO | 2469: exit 0 08:18:23 INFO - Browser initialized. 08:18:23 INFO - Running cycle 1/1 for kraken test... 08:18:23 INFO - TEST-INFO | started process 2470 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/T/tmp9VgFNd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:35 INFO - PROCESS | 2470 | RSS: Main: 214896640 08:18:35 INFO - PROCESS | 2470 | 08:18:37 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:62309/tests/kraken/driver.html?testName=audio-beat-detection) 08:18:38 INFO - PROCESS | 2470 | RSS: Main: 268742656 08:18:38 INFO - PROCESS | 2470 | 08:18:41 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:62309/tests/kraken/driver.html?testName=audio-dft) 08:18:42 INFO - PROCESS | 2470 | RSS: Main: 280883200 08:18:42 INFO - PROCESS | 2470 | 08:18:45 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:62309/tests/kraken/driver.html?testName=audio-fft) 08:18:45 INFO - PROCESS | 2470 | RSS: Main: 377200640 08:18:45 INFO - PROCESS | 2470 | 08:18:47 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:62309/tests/kraken/driver.html?testName=audio-oscillator) 08:18:48 INFO - PROCESS | 2470 | RSS: Main: 279539712 08:18:48 INFO - PROCESS | 2470 | 08:18:50 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:62309/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:51 INFO - PROCESS | 2470 | RSS: Main: 280756224 08:18:51 INFO - PROCESS | 2470 | 08:18:54 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:62309/tests/kraken/driver.html?testName=imaging-darkroom) 08:18:54 INFO - PROCESS | 2470 | RSS: Main: 320438272 08:18:54 INFO - PROCESS | 2470 | 08:18:57 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:62309/tests/kraken/driver.html?testName=imaging-desaturate) 08:18:58 INFO - PROCESS | 2470 | RSS: Main: 320417792 08:18:58 INFO - PROCESS | 2470 | 08:19:01 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:62309/tests/kraken/driver.html?testName=json-parse-financial) 08:19:01 INFO - PROCESS | 2470 | RSS: Main: 320057344 08:19:01 INFO - PROCESS | 2470 | 08:19:03 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:62309/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:19:04 INFO - PROCESS | 2470 | RSS: Main: 294674432 08:19:04 INFO - PROCESS | 2470 | 08:19:05 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:62309/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:19:06 INFO - PROCESS | 2470 | RSS: Main: 297160704 08:19:06 INFO - PROCESS | 2470 | 08:19:08 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:62309/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:19:09 INFO - PROCESS | 2470 | RSS: Main: 301719552 08:19:09 INFO - PROCESS | 2470 | 08:19:12 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:62309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:19:13 INFO - PROCESS | 2470 | RSS: Main: 320311296 08:19:13 INFO - PROCESS | 2470 | 08:19:16 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:62309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:19:16 INFO - PROCESS | 2470 | RSS: Main: 313753600 08:19:16 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | Cycle 1(1): loaded http://localhost:62309/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:62309/tests/kraken/driver.html?testName=ai-astar) 08:19:18 INFO - PROCESS | 2470 | RSS: Main: 358109184 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | __start_tp_report 08:19:18 INFO - PROCESS | 2470 | _x_x_mozilla_page_load 08:19:18 INFO - PROCESS | 2470 | _x_x_mozilla_page_load_details 08:19:18 INFO - PROCESS | 2470 | |i|pagename|runs| 08:19:18 INFO - PROCESS | 2470 | |0;ai-astar;115;117;116;115;115;116;114;116;116;113 08:19:18 INFO - PROCESS | 2470 | |1;audio-beat-detection;151;106;105;147;111;113;109;109;135;135 08:19:18 INFO - PROCESS | 2470 | |2;audio-dft;186;187;185;187;184;184;184;184;186;186 08:19:18 INFO - PROCESS | 2470 | |3;audio-fft;84;59;62;94;64;62;75;88;78;61 08:19:18 INFO - PROCESS | 2470 | |4;audio-oscillator;87;70;89;69;70;68;82;69;69;87 08:19:18 INFO - PROCESS | 2470 | |5;imaging-gaussian-blur;87;86;87;87;88;86;87;90;87;87 08:19:18 INFO - PROCESS | 2470 | |6;imaging-darkroom;94;93;94;96;93;93;94;97;94;105 08:19:18 INFO - PROCESS | 2470 | |7;imaging-desaturate;83;87;86;86;84;84;83;85;86;84 08:19:18 INFO - PROCESS | 2470 | |8;json-parse-financial;65;60;61;61;62;66;64;64;62;63 08:19:18 INFO - PROCESS | 2470 | |9;json-stringify-tinderbox;54;62;62;66;61;58;59;60;60;62 08:19:18 INFO - PROCESS | 2470 | |10;stanford-crypto-aes;83;85;84;84;86;84;82;83;87;91 08:19:18 INFO - PROCESS | 2470 | |11;stanford-crypto-ccm;149;149;143;141;137;141;142;142;203;175 08:19:18 INFO - PROCESS | 2470 | |12;stanford-crypto-pbkdf2;172;208;204;163;166;164;195;164;166;170 08:19:18 INFO - PROCESS | 2470 | |13;stanford-crypto-sha256-iterative;65;68;80;81;84;83;72;63;63;64 08:19:18 INFO - PROCESS | 2470 | __end_tp_report 08:19:18 INFO - PROCESS | 2470 | __start_cc_report 08:19:18 INFO - PROCESS | 2470 | _x_x_mozilla_cycle_collect,2210 08:19:18 INFO - PROCESS | 2470 | __end_cc_report 08:19:18 INFO - PROCESS | 2470 | __startTimestamp1490282358854__endTimestamp 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | ------- Summary: start ------- 08:19:18 INFO - PROCESS | 2470 | Number of tests: 14 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:1.16 (1.0%) stddev-sans-first:1.22 08:19:18 INFO - PROCESS | 2470 | Values: 115.0 117.0 116.0 115.0 115.0 116.0 114.0 116.0 116.0 113.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:124.00 stddev:17.92 (14.4%) stddev-sans-first:15.66 08:19:18 INFO - PROCESS | 2470 | Values: 151.0 106.0 105.0 147.0 111.0 113.0 109.0 109.0 135.0 135.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#2] audio-dft Cycles:10 Average:185.30 Median:186.00 stddev:1.25 (0.7%) stddev-sans-first:1.30 08:19:18 INFO - PROCESS | 2470 | Values: 186.0 187.0 185.0 187.0 184.0 184.0 184.0 184.0 186.0 186.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#3] audio-fft Cycles:10 Average:72.70 Median:76.50 stddev:12.82 (16.8%) stddev-sans-first:12.92 08:19:18 INFO - PROCESS | 2470 | Values: 84.0 59.0 62.0 94.0 64.0 62.0 75.0 88.0 78.0 61.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:76.00 stddev:9.01 (11.9%) stddev-sans-first:8.63 08:19:18 INFO - PROCESS | 2470 | Values: 87.0 70.0 89.0 69.0 70.0 68.0 82.0 69.0 69.0 87.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:87.00 stddev:1.14 (1.3%) stddev-sans-first:1.20 08:19:18 INFO - PROCESS | 2470 | Values: 87.0 86.0 87.0 87.0 88.0 86.0 87.0 90.0 87.0 87.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#6] imaging-darkroom Cycles:10 Average:95.30 Median:94.00 stddev:3.65 (3.9%) stddev-sans-first:3.84 08:19:18 INFO - PROCESS | 2470 | Values: 94.0 93.0 94.0 96.0 93.0 93.0 94.0 97.0 94.0 105.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.50 stddev:1.40 (1.6%) stddev-sans-first:1.32 08:19:18 INFO - PROCESS | 2470 | Values: 83.0 87.0 86.0 86.0 84.0 84.0 83.0 85.0 86.0 84.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.50 stddev:1.93 (3.0%) stddev-sans-first:1.88 08:19:18 INFO - PROCESS | 2470 | Values: 65.0 60.0 61.0 61.0 62.0 66.0 64.0 64.0 62.0 63.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#9] json-stringify-tinderbox Cycles:10 Average:60.40 Median:61.50 stddev:3.13 (5.1%) stddev-sans-first:2.32 08:19:18 INFO - PROCESS | 2470 | Values: 54.0 62.0 62.0 66.0 61.0 58.0 59.0 60.0 60.0 62.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:84.50 stddev:2.60 (3.1%) stddev-sans-first:2.67 08:19:18 INFO - PROCESS | 2470 | Values: 83.0 85.0 84.0 84.0 86.0 84.0 82.0 83.0 87.0 91.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#11] stanford-crypto-ccm Cycles:10 Average:152.20 Median:146.00 stddev:20.80 (14.2%) stddev-sans-first:22.03 08:19:18 INFO - PROCESS | 2470 | Values: 149.0 149.0 143.0 141.0 137.0 141.0 142.0 142.0 203.0 175.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.20 Median:171.00 stddev:17.84 (10.4%) stddev-sans-first:18.82 08:19:18 INFO - PROCESS | 2470 | Values: 172.0 208.0 204.0 163.0 166.0 164.0 195.0 164.0 166.0 170.0 08:19:18 INFO - PROCESS | 2470 | 08:19:18 INFO - PROCESS | 2470 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.30 Median:76.00 stddev:8.82 (11.6%) stddev-sans-first:8.95 08:19:18 INFO - PROCESS | 2470 | Values: 65.0 68.0 80.0 81.0 84.0 83.0 72.0 63.0 63.0 64.0 08:19:18 INFO - PROCESS | 2470 | -------- Summary: end -------- 08:19:18 INFO - PROCESS | 2470 | 08:19:19 INFO - TEST-INFO | 2470: exit 0 08:19:19 INFO - TEST-OK | kraken | took 59747ms 08:19:19 INFO - SUITE-END | took 1179s 08:19:20 INFO - Completed test suite (00:19:39) 08:19:20 INFO - javascript benchmark 08:19:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7674.687592412735, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2734.7401996810304, 3382.8139452330142, 3401.982990085049, 3422.7946323220626, 3448.4654878493825, 4893.510648935105, 6001.519878409727, 6027.487663548603, 6046.395360463951, 6052.667103309316, 5995.6102853314505, 6057.575969682124, 6057.848553786158, 6075.787347442841, 6085.934961381763, 5388.164834450657, 5397.595180361469, 5435.864103397427, 5514.834554963358, 5517.5585953123855, 5298.708571028592, 5316.893662126755, 5509.669419834802, 5516.475934786189, 5516.724163791814, 5384.946150538483, 5399.352077750656, 5417.160340147283, 5430.511253987141, 5454.59090568207, 5445.047116754552, 5445.727713614323, 5455.0453670607485, 5458.399576046631, 5468.99999999998, 5294.549963253128, 5397.7031263280505, 5403.972980135074, 5422.40353561108, 5426.728663566806, 6087.817365479043, 6089.665068421235, 6090.42140996609, 6094.055421409645, 6094.39056094387, 6289.37106289372, 6304.684765761694, 6310.936890631081, 6313.116163737081, 6322.178116844827, 6322.683865806737, 6324.3991820776955, 6340.3659634036685, 6342.619442833398, 6352.269489008777, 6059.484943779784, 6118.20463339763, 6138.386161383826, 6153.938460615382, 6156.292026416974, 6561.507886908501, 6571.67141642916, 6580.4406625436895, 6583.736650533973, 6594.934050659432, 6209.844753881099, 6247.718852651642, 6251.343608921089, 6265.091561723524, 6310.684465776784, 6455.515836312202, 6470.579412338183, 6473.546851720334, 6481.675916204171, 6489.1888513935755, 6366.458850997625, 6379.298277189506, 6392.20097487814, 6393.944999075194, 6400.327965563549, 6232.0963460298, 6284.277308109535, 6307.873842523124, 6399.424051835357, 6405.583637063576, 5104.540591346797, 5127.820526281562, 5185.196294574347, 5192.091384007784, 5214.7914083437, 4589.885252868705, 4593.448786145684, 4609.078184363141, 4609.2394754865745, 4625.398698169217, 5861.824145275648, 6076.5442591805795, 6107.29766076898, 6111.54163437735, 6128.387161283836, 6325.873482530324, 6327.114204011442, 6331.905021424683, 6345.36546345371, 6369.172007638977, 6032.517398608188, 6061.151438798572, 6068.939310606837, 6076.058210977306, 6084.087386891913, 5647.209390685307, 5658.801941932013, 5663.32040155184, 5675.687837168913, 5681.261436013375, 5424.0, 6365.077063825626, 6375.904361434675, 6502.642354670538, 6658.766943157063, 6285.025820997753, 6303.212098487689, 6305.369463053658, 6313.621182729051, 6315.147455093687, 5938.584299099021, 6361.886669832853, 6564.6389448578875, 6729.024291477611, 6741.393274605309, 6312.7159277833525, 6381.840453988688, 6398.584092034003, 6401.743930242738, 6405.103285539935, 6320.1467801848, 6438.742450301936, 6454.870902581828, 6458.22501299847, 6474.125992991075, 5102.413222479462, 6194.690265486798, 6240.968795155995, 6266.122742816101, 6301.275353334425, 6310.558260921692, 6318.6840657965995, 6319.557630965788, 6322.683865806784, 6328.272248691275, 6297.118403423433, 6308.936910631019, 6316.463100636497, 6316.810495685137, 6323.936760632335, 6173.84565385869, 6200.968995154995, 6235.719392627433, 6250.968745156245, 6335.429811317003, 6210.4100110489435, 6213.875722485615, 6281.0, 6288.245410550763, 6289.7484100635465], "value": 5896.505024120986, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.7313947560451, 736.1828370508738, 810.7932477218309, 877.4472082587969, 891.8706787515806, 27935.441291174164, 40023.79988100059, 40849.79575102128, 40867.38698919515, 41028.79485602575, 40158.598414015854, 40359.596404035954, 40392.0, 40413.797931010304, 40446.79776601113, 7293.7082516699265, 8794.604242809057, 8960.820783584324, 8969.058248883872, 8974.057723938959, 7380.261973802631, 7422.0, 7454.739084132057, 7461.813454663623, 7463.402927765793, 10839.078678312353, 11028.669139925814, 11157.442127893613, 11215.327080375162, 11224.66326010221, 10984.560617575287, 11030.172737044753, 11030.834537481944, 11042.171837112248, 11045.83431248532, 7256.383207427375, 7439.330460258549, 10907.618233361794, 10988.890111098866, 10988.956049175316, 27820.443591128267, 28003.71996280052, 28074.578881316796, 38601.42097868534, 39149.41275880864, 3686.7972261525606, 3688.22547265072, 3871.6902647788393, 3911.0808959894403, 3918.922296368493, 24696.753032469624, 25929.0, 26280.86859565709, 26540.07109751169, 26552.867235663893, 3066.9079927602206, 3072.2933725243097, 3106.689331066898, 3110.9533356999664, 3141.748660107186, 355191.0, 357017.2149139264, 357465.0, 357749.0, 358065.0, 45846.31230531545, 48042.27936580954, 53645.0, 54954.0, 55100.448995509534, 49753.25370119451, 50127.997440051724, 50205.74897125491, 50208.497915021115, 50247.748761255956, 14827.92586037063, 14895.0, 14897.925510372379, 14907.0, 14916.328765205591, 10624.628138015132, 12786.041046921519, 12822.487100515875, 12851.0, 12877.806832897513, 10499.317544359592, 10706.197035222389, 10732.570697172026, 11952.34262115592, 12218.877811221952, 4771.196148096378, 4865.70805751656, 5487.859734703469, 5705.144228365778, 5712.742926568314, 1111.5887121765, 1129.5764088466824, 1131.7793030359167, 1157.5935238685038, 1167.3054532553117, 26924.461510769674, 26952.191434257005, 27263.045793397137, 27334.45331093367, 27495.587566186525, 1150.7871043856912, 1245.5578269714301, 1271.4596296573918, 1289.2844471318322, 1294.7604693131611, 11351.545938162546, 13172.209667419986, 13936.0, 14124.081934674214, 14255.50105746294, 488587.0, 490111.0, 490142.0, 491794.0, 492568.0, 57418.425815741306, 57798.13302800462, 57809.71095144498, 57907.420925790204, 57949.0, 1427.5931359562683, 1466.8313143988578, 1469.7207530568944, 1471.2055490035261, 1475.9262036898112, 25207.747922521274, 26022.73977260203, 26265.343366415993, 26713.19860404191, 27206.319842003315, 46642.067158657315, 46668.299975499714, 46727.29909051299, 46728.29907551457, 46735.831604210165, 454617.0, 458263.0, 458540.0, 458917.0, 459216.0, 32612.0, 33076.0, 33183.0, 33288.667113328556, 33294.0, 44346.778266108464, 44493.77753111214, 45328.54671453243, 45758.54241457543, 46092.53907460882, 32794.67205327916, 35492.46761298531, 36275.63724362723, 36432.0, 36888.0, 30719.924802632693, 33268.0, 36404.27191456103, 36760.26479470449, 37607.811960940024, 35387.82306088453, 35625.287494250486, 36783.44824827576, 36798.63201368059, 37217.25565488729, 22459.0, 27288.538494889377, 30991.690083099784, 31055.913043043383, 31106.222344440666, 24011.75988240095, 24067.0, 24076.277711668678, 24659.876700616383, 24782.628260575744], "value": 18622.389903758994, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.15060544526517, 408.44859439756334, 421.80596925414306, 430.78891343241816, 446.6002927379995, 12759.744805103905, 14551.490697825579, 19218.039098045112, 20720.89639551802, 21559.245426410078, 18488.72266915994, 21110.788892111075, 22082.668759968612, 22500.0, 23159.84200789958, 6412.102305677209, 6439.935600643992, 6658.500612454061, 6700.463962882982, 6748.358905903956, 4134.834606615732, 4400.691951563392, 6626.93373066268, 6627.536072474929, 6692.531522793406, 4363.607275345218, 7620.885686714703, 7639.083310002808, 7640.7325743598985, 7660.195679453661, 7394.334509894135, 7592.620368981528, 7611.429142814283, 7614.619269036526, 7690.500117492345, 7258.947452619341, 7268.745593904241, 7453.0, 7483.625818709097, 7487.513311634781, 27122.050728224418, 27136.592951105747, 27212.31969200766, 27403.31491712703, 27524.724752752616, 2686.130804192845, 3297.8351082445784, 3389.5085212644276, 3498.4577390504514, 3543.433050711874, 15052.473163439226, 15292.0, 15397.769033464507, 15505.534833955, 15509.0, 1991.3415590187117, 2028.3914825552276, 2035.185925629745, 2095.21429463951, 2095.256184054669, 92607.0, 118157.29980565533, 118880.0, 121517.0, 122676.38661806723, 20851.58296834055, 21194.364169074954, 21340.253091141734, 21435.67846482304, 21474.141034358763, 34601.82699086489, 35017.64982350144, 35394.0, 35428.29143417117, 35527.822360888546, 10699.983501567338, 10711.94644026775, 10787.137029037658, 10927.125829933586, 11079.224454288284, 8890.86663700045, 8899.243564296978, 8923.196912277795, 9054.592543335566, 9077.636894524278, 9949.850752238723, 10238.692839214686, 10349.430781307101, 10363.533640986174, 10388.636397726195, 3991.3214753491975, 4076.7553946763287, 4106.938395924063, 4110.608747783091, 4111.6299533042165, 1025.3284098915221, 1032.210359075293, 1080.3524624946863, 1096.5230124895695, 1131.5869707556847, 22766.544669106526, 23179.884100579387, 23192.18827341035, 23212.535749284918, 23336.949837257365, 1015.8476228565775, 1019.3017782818793, 1085.664632502027, 1088.4394536813547, 1136.9488373023069, 10935.56257749697, 11137.944310278397, 12089.000363287143, 12118.81821772674, 12177.634670959886, 726526.0, 754536.0, 756845.0, 767206.1639691878, 790978.0, 77329.0, 121552.0, 122213.0, 126464.0, 127245.0, 1222.8654847966716, 1244.975100498003, 1261.394530625305, 1264.5953294945714, 1264.791309433933, 19544.413667589994, 19548.924809135635, 20074.39776806698, 20100.497487562927, 20147.69778453295, 48230.75884620695, 52992.0, 53977.0, 54573.72713136409, 54717.0, 61232.775344493755, 62799.0, 72209.0, 74199.0, 74522.0, 11510.964013238849, 11901.226420282654, 12133.69665758363, 12248.0, 12417.875821241672, 13104.0, 13139.408726607135, 13143.868561314264, 13311.33443327849, 13326.466941322238, 11157.27477713946, 11183.664490065312, 11259.099272058053, 11474.541018359507, 11665.825012624988, 10385.896141038795, 10851.565937362417, 11319.0, 11425.0, 11544.365059921785, 11298.265612735146, 11527.250728702607, 11667.066634669376, 11785.292882427082, 11822.881771182178, 11038.44807759625, 11327.943360283145, 11373.886261137282, 11450.370229637118, 11669.0, 10884.836727449254, 11161.0, 11255.099592032453, 11356.602518911799, 11364.715882103013], "value": 11533.698717087762, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1360.476216656587, 1544.7914531538247, 1561.5393458929614, 1571.2458020150327, 1583.8020247469067, 10595.682129536117, 11559.826602600946, 11575.42122893854, 11579.768404631903, 11582.53669853206, 10810.783784324329, 11229.887701123007, 11447.370394628291, 11452.541898324058, 11459.770804583903, 2418.854868707874, 2471.8393304435244, 2472.8006916645413, 2473.950520989579, 2474.05985725425, 2341.66045923341, 2373.8694371809543, 2379.2505360811374, 2380.773826486481, 2381.226101517005, 2396.5206958608346, 2416.6858308419883, 2422.709274887016, 2426.8179886508583, 2429.7327293997646, 2028.4421784009514, 2371.2886134159685, 2376.287113865842, 2385.689860318165, 2397.85612863227, 2321.6749655048307, 2326.7324257710243, 2397.832151749378, 2403.134871446278, 2406.1217655555597, 10543.578256869716, 10655.733606659818, 10669.359838409642, 10680.412577308245, 10693.198010149192, 5790.247267855194, 6018.15745795589, 6024.8493787655225, 6029.577929544934, 6031.396860313977, 3537.876174333912, 3578.284343131358, 3631.3100510902846, 3679.889603311905, 3707.610700876396, 1175.864775550814, 1185.2651356159236, 1202.1945296651265, 1248.950041998319, 1266.8986481081492, 13764.449422023206, 14070.22613756243, 14427.855721442756, 15312.464063757716, 15469.690606187925, 4027.0692149546967, 4235.597618226325, 4357.106793107406, 4367.75977321244, 4416.271315232951, 11745.236559623598, 11770.0, 11789.233699809485, 11798.0, 11818.409079545989, 5900.1739756434135, 5909.586328957018, 5913.852153696192, 5913.940860591425, 5923.318818335861, 5098.260752190911, 5263.315768950012, 5277.445868183862, 5348.1442969124755, 5376.811811586654, 3809.4285857121654, 3849.40334248192, 3900.063984643665, 3924.1955399143108, 3944.3294639911283, 1035.1511760356436, 1035.2597892506894, 1039.6413237433073, 1046.2048842879315, 1053.4995876958537, 890.9777255568663, 916.6241840845355, 924.1497822003772, 937.7702462896498, 965.2085290062082, 5859.740155866509, 6542.585434201493, 6566.080748695186, 6612.471002319803, 6678.065070890079, 926.1803304075942, 967.709687093869, 969.413504829582, 974.9756256093655, 1011.9392836429838, 3215.9917543755196, 3941.586133455946, 4174.436451079066, 4205.222033923734, 4427.800748966304, 13312.0, 13801.723965520834, 13807.378667959965, 13810.033297669268, 13866.376013079436, 13400.664983375298, 13626.0, 13757.037007409384, 13757.38091785872, 13767.655808604664, 8656.350773692124, 10085.142762865238, 10136.0, 10230.948845255725, 10242.129418999319, 5802.274715660543, 5868.882622347443, 6767.661616919233, 6994.405475534637, 7017.052697885924, 11707.824382634437, 11977.401129943642, 12132.75734485323, 12148.392580371123, 12151.939240303742, 12280.447379867748, 12752.6811829705, 12905.612831615066, 12931.094823362275, 12937.935310323388, 8229.95885020571, 8465.449745766506, 8474.576271186294, 8503.319734421108, 8523.318134549098, 10108.797824043624, 10314.638987635397, 10416.11463025621, 10434.321769084985, 10435.895641043493, 9046.819063618559, 9135.497547634677, 9290.442573445614, 9371.578278977326, 9491.335606507479, 9167.12912273333, 9174.990751017516, 9181.449113053239, 9260.981292058003, 9342.719718408458, 7884.763457096296, 8041.155678653658, 8049.678012879419, 8050.718224862102, 8061.798455038671, 5797.884042319214, 5803.245578074992, 5878.2064421302575, 6027.728752206249, 6088.543359247986, 5788.9131663024245, 5886.940350736909, 5938.435848594377, 6161.199044124235, 6269.905951410824], "value": 5127.520419505059, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.72353182177017, 379.9354109801333, 384.1816929939229, 388.3785942492013, 391.66247265588, 4372.726182385158, 4560.30615201686, 5105.668131571445, 5160.329157209562, 5299.178627312773, 4602.918314196161, 4899.0, 5003.3488948646955, 5099.0, 5155.370760911934, 3244.6430892601793, 3551.5027896094566, 3784.6942804732325, 3992.9800350998203, 4008.418779277003, 3568.4468907319406, 3861.2470568239205, 4035.8183881725245, 4075.2257071156387, 4078.2047500737367, 4042.8382864685523, 4045.9595404045876, 4049.6107296694945, 4059.451973983504, 4074.7351422157612, 3413.1808365992106, 3572.982135089308, 3749.550053993511, 3959.75300253792, 4029.657479114279, 3327.45097058985, 3353.0779035765117, 3540.522029526007, 3552.715782737375, 3562.786232826039, 3997.520297564282, 4034.838606455738, 4761.547652972962, 4789.592884604813, 4935.556899334816, 4068.7355321903983, 4364.908772806798, 4508.977455112737, 4509.954900450986, 4645.279981602857, 4965.155923493015, 5346.251524786533, 5395.595330350239, 5400.78396864125, 5450.427705090948, 3514.6309637487952, 3711.4247291669835, 3978.5822488638564, 3983.64147226751, 3983.8605648802154, 4791.9520804791855, 4911.9754401227765, 5566.2207290979295, 5694.999999999958, 5700.8859822803315, 4102.466679331667, 4309.1381723655395, 4366.323219900921, 4795.784189711471, 4878.536539028786, 4365.410669559632, 4729.69256998294, 4943.2585112233455, 4967.4784147664695, 5020.698758074527, 4215.641670458045, 4571.000374672162, 4637.634806248838, 4959.504049595012, 5121.897562048738, 4806.615470762331, 5154.845354639367, 5259.579233661298, 5456.0, 5490.709683224439, 1470.5441313192944, 1507.974577287433, 1670.8663306935416, 1684.6546457976085, 1694.8051623605575, 1274.9235045897276, 1303.419978109732, 1353.82893796865, 1367.3983447283163, 1385.009718051598, 4801.663883528119, 4922.75386230687, 5060.15428274514, 5086.5422112009355, 5101.464346243591, 5060.696358218519, 5072.5688316493515, 5591.664500129924, 5608.859778505488, 5626.774929002794, 4737.502562230985, 4842.661013729075, 5032.521910418504, 5080.441151473335, 5087.23691446286, 2375.382400575863, 2877.6259086318646, 2923.766098712098, 2926.780491463106, 2931.6042334285025, 4868.14807408702, 5071.492850714899, 5225.458489745458, 5491.752871120809, 5579.079451890392, 4943.975280123576, 5037.596992240685, 5707.800226992035, 5779.590041875314, 5791.739371728282, 4971.90056198874, 5285.546474719406, 5383.623146379716, 5733.684647344436, 5792.594518383673, 4880.901797095625, 5396.244525766318, 5556.083246264483, 5589.546717853469, 5648.943510565006, 5232.5552328052545, 5497.367802702581, 5542.5565954722715, 5554.333919718477, 5560.304961879765, 5112.079825631274, 5176.0, 5378.569714422759, 5640.746166422438, 5826.388229235869, 4456.487503936959, 4492.955070449254, 4504.121696269196, 4567.748773817339, 4568.680192386501, 4931.753412329441, 5109.131447653834, 5588.944110558842, 5600.635958662674, 5615.686744820576, 4893.266010098514, 5196.142636464941, 5203.453637368022, 5412.809181979958, 5440.972795135999, 4782.736949467812, 4965.343541205582, 5205.401378841481, 5405.324379422031, 5438.564914806885, 4242.278812601803, 4396.890077747954, 4669.859904202879, 4933.654644174873, 5209.76556054986, 4354.303311470149, 4966.900661986668, 5171.301874247079, 5475.589330800126, 5484.588655850907, 4240.851570195028, 4744.430668319824, 5339.332583427072, 5364.436734142859, 5417.702026388586], "value": 4114.2353835315425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [715.8997740316356, 727.1710250314638, 730.9707611695533, 765.7894079128239, 838.2790799912075, 14908.478203262874, 15516.0, 15628.055650689173, 15748.76376854348, 15897.52307430776, 14131.434742610283, 14275.2862356882, 14495.42018319266, 14530.782038269408, 14675.486357977474, 904.3398319226985, 922.2253307221932, 926.5691453474133, 930.702175303903, 932.0213775535694, 918.7243826851918, 922.4511415707643, 957.8132264208482, 965.946872921989, 966.9081437263484, 998.1316254858283, 1002.6641075239803, 1003.7490627343165, 1005.708344580071, 1005.8440941654055, 996.9551370188286, 997.5710444508858, 999.4752754803714, 1000.1898462245605, 1002.3484734922285, 745.6495447139836, 747.3348719639471, 747.8429529798749, 750.4146765522901, 751.8458715963214, 15280.38878444872, 15679.0, 15807.367705291774, 16103.516894493185, 16390.0, 13888.375023123883, 14186.639012010814, 14212.360443780055, 14239.501617443444, 14249.928750356286, 11565.884341156649, 11745.177837551375, 11909.583164589198, 12079.516819327217, 12373.381330933418, 3607.549056367954, 3656.4880916671686, 3706.629337066299, 3735.962640373589, 3852.114013776847, 108190.91809081887, 109623.0, 110389.34415983767, 112916.30625540705, 113015.43492282568, 10512.632057877938, 10702.678919632424, 10721.0, 10752.946235268773, 11281.492332845042, 22210.66683999741, 22421.66367504489, 22432.66351004736, 22434.102635894382, 22511.0, 7637.618119094023, 7732.6133693315105, 7742.961285193538, 7862.488938219112, 7895.210478952059, 4306.4832220133785, 4308.5045219799495, 4357.54245804186, 4375.431193944767, 4427.424434823452, 3464.566929133858, 3528.770629909048, 3553.218291975761, 3563.1626567756557, 3570.339487194877, 634.7651368993502, 639.6993413095837, 644.6196743921109, 644.9967750161313, 645.8159424563977, 661.1669296686114, 667.9131712877295, 670.5440300595642, 683.7435961514432, 729.9160596531467, 9563.426194428357, 9781.951090244645, 10327.638532651321, 10329.32859364154, 10508.474576271155, 655.6918248423234, 679.78246960973, 691.8616276744672, 701.6604974059451, 721.4516967105038, 4644.60520855731, 4898.853034408973, 4904.950950490521, 4912.091263116335, 4923.187674033816, 99812.00375992585, 103663.11537288476, 105291.0, 105395.41906871404, 107039.0, 66451.66774166099, 72322.63838680879, 90783.0, 92420.53789731009, 94924.52537737267, 82519.0, 83636.58181709175, 83705.0, 84770.0, 85494.57252713821, 9408.482533460725, 9421.528923553658, 9423.10480504351, 9428.858567121362, 9457.43255404678, 44667.55332446634, 45735.771321143184, 51161.46515604538, 51793.115516335674, 53391.73304133455, 50008.499915000386, 63358.366416335244, 64130.35869641244, 64309.03536446863, 64665.67667161634, 12945.96432285396, 12960.724476854803, 12998.675033124247, 13111.934440327737, 13356.296018969175, 14587.843297652606, 14648.85351146475, 14667.706645867236, 14912.328945197276, 15104.169270690218, 13644.863551364358, 14003.649908752363, 14006.78989815174, 14094.013419060977, 14292.571222863331, 13629.318534073454, 13758.243296618783, 14073.155610663393, 14250.928745356621, 14589.854101459274, 12598.496060157857, 13032.850414356346, 13614.115082519604, 13639.181649101085, 13902.51341203053, 10755.516001780095, 10999.670009899715, 11509.96410323075, 11631.53473861036, 11674.94162529182, 8123.038541119892, 8898.644054237759, 10347.84478232812, 11211.439428028729, 11874.287542747463], "value": 7647.630140810472, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1448.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 117.0, 116.0, 115.0, 115.0, 116.0, 114.0, 116.0, 116.0, 113.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 106.0, 105.0, 147.0, 111.0, 113.0, 109.0, 109.0, 135.0, 135.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 185.0, 187.0, 184.0, 184.0, 184.0, 184.0, 186.0, 186.0], "value": 185.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 59.0, 62.0, 94.0, 64.0, 62.0, 75.0, 88.0, 78.0, 61.0], "value": 72.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 70.0, 89.0, 69.0, 70.0, 68.0, 82.0, 69.0, 69.0, 87.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 87.0, 88.0, 86.0, 87.0, 90.0, 87.0, 87.0], "value": 87.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 96.0, 93.0, 93.0, 94.0, 97.0, 94.0, 105.0], "value": 95.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 87.0, 86.0, 86.0, 84.0, 84.0, 83.0, 85.0, 86.0, 84.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 60.0, 61.0, 61.0, 62.0, 66.0, 64.0, 64.0, 62.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 62.0, 66.0, 61.0, 58.0, 59.0, 60.0, 60.0, 62.0], "value": 60.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 84.0, 84.0, 86.0, 84.0, 82.0, 83.0, 87.0, 91.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 143.0, 141.0, 137.0, 141.0, 142.0, 142.0, 203.0, 175.0], "value": 152.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 208.0, 204.0, 163.0, 166.0, 164.0, 195.0, 164.0, 166.0, 170.0], "value": 177.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 80.0, 81.0, 84.0, 83.0, 72.0, 63.0, 63.0, 64.0], "value": 72.3, "unit": "score"}]}]} 08:19:20 INFO - Return code: 0 08:19:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:19:20 ERROR - # TBPL SUCCESS # 08:19:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:19:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:19:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:19:20 INFO - 2017-03-23 08:19:20.207 screenresolution[2474:36807] starting screenresolution argv=screenresolution get 08:19:20 INFO - 2017-03-23 08:19:20.209 screenresolution[2474:36807] Display 0: 1600x1200x32@60 08:19:20 INFO - 2017-03-23 08:19:20.216 screenresolution[2475:36810] starting screenresolution argv=screenresolution list 08:19:20 INFO - Available Modes on Display 0 08:19:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:19:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:19:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:19:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:19:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:19:20 INFO - Intel Iris: 08:19:20 INFO - Chipset Model: Intel Iris 08:19:20 INFO - Type: GPU 08:19:20 INFO - Bus: Built-In 08:19:20 INFO - VRAM (Dynamic, Max): 1536 MB 08:19:20 INFO - Vendor: Intel (0x8086) 08:19:20 INFO - Device ID: 0x0a2e 08:19:20 INFO - Revision ID: 0x0009 08:19:20 INFO - Displays: 08:19:20 INFO - Display: 08:19:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:19:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:19:20 INFO - Display Serial Number: 1600x1200 60 08:19:20 INFO - Main Display: Yes 08:19:20 INFO - Mirror: Off 08:19:20 INFO - Online: Yes 08:19:20 INFO - Rotation: Supported 08:19:20 INFO - Return code: 0 08:19:20 INFO - Running post-action listener: _resource_record_post_action 08:19:20 INFO - [mozharness: 2017-03-23 15:19:20.457358Z] Finished run-tests step (success) 08:19:20 INFO - Running post-run listener: _resource_record_post_run 08:19:20 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 126976; Write bytes: 508433408; Read time: 1; Write time: 1823 08:19:20 INFO - TinderboxPrint: CPU usage
53.8% 08:19:20 INFO - TinderboxPrint: I/O read bytes / time
126,976 / 1 08:19:20 INFO - TinderboxPrint: I/O write bytes / time
508,433,408 / 1,823 08:19:20 INFO - TinderboxPrint: CPU idle
2,218.3 (46.2%) 08:19:20 INFO - TinderboxPrint: CPU system
959.3 (20.0%) 08:19:20 INFO - TinderboxPrint: CPU user
1,624.0 (33.8%) 08:19:20 INFO - TinderboxPrint: Swap in / out
208,347,136 / 0 08:19:20 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204227072; Write bytes: 202990080; Read time: 15798; Write time: 426 08:19:20 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 126976; Write bytes: 294621696; Read time: 1; Write time: 1362 08:19:20 INFO - Running post-run listener: _upload_blobber_files 08:19:20 INFO - Blob upload gear active. 08:19:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:19:20 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 08:19:20 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'] 08:19:20 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 08:19:21 INFO - (blobuploader) - INFO - Open directory for files ... 08:19:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:19:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:19:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:22 INFO - (blobuploader) - INFO - Done attempting. 08:19:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:19:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:19:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:23 INFO - (blobuploader) - INFO - Done attempting. 08:19:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:19:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:19:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:24 INFO - (blobuploader) - INFO - Done attempting. 08:19:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:19:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:19:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:26 INFO - (blobuploader) - INFO - Done attempting. 08:19:26 INFO - (blobuploader) - INFO - Iteration through files over. 08:19:26 INFO - Return code: 0 08:19:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:19:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:19:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/563daa76d7d00faa673dfac41d7dc7486cd785dedb426750c56ab172e3407a7eebb8f30043fc5edc4b5848d802a6d149b29ab74fd83941a48307ea959c180836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21bb6ae9b69459b30e83811bda3a9eaa012493528b4bc6c43a69360c0859159d35793ca7627fab425bfe38c2e09cd86225bbab84b4b68e1e6c6dea8cae5c52c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e321143708b1c46e212e243d3a2753bdf5bf0e18eca67d8e053d61941d3a2968e9b2f2aab3607dae038f0e2787c15c002539f6d503570d24eec1d4e4373546ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea4041fb82a30eda990d33d86eca520caa3cd9b3f6db8616d044784a6a58b7a5c33ea130c885f93c28666ac4f0734d3b95b003067a71b3e572af8b6c64e815ef"} 08:19:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:19:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:19:26 INFO - Contents: 08:19:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/563daa76d7d00faa673dfac41d7dc7486cd785dedb426750c56ab172e3407a7eebb8f30043fc5edc4b5848d802a6d149b29ab74fd83941a48307ea959c180836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21bb6ae9b69459b30e83811bda3a9eaa012493528b4bc6c43a69360c0859159d35793ca7627fab425bfe38c2e09cd86225bbab84b4b68e1e6c6dea8cae5c52c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e321143708b1c46e212e243d3a2753bdf5bf0e18eca67d8e053d61941d3a2968e9b2f2aab3607dae038f0e2787c15c002539f6d503570d24eec1d4e4373546ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea4041fb82a30eda990d33d86eca520caa3cd9b3f6db8616d044784a6a58b7a5c33ea130c885f93c28666ac4f0734d3b95b003067a71b3e572af8b6c64e815ef"} 08:19:26 INFO - Running post-run listener: copy_logs_to_upload_dir 08:19:26 INFO - Copying logs to upload dir... 08:19:26 INFO - mkdir: /builds/slave/test/build/upload/logs 08:19:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.782546 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-23 08:19:26.087174) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 08:19:26.093471) ========= 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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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/563daa76d7d00faa673dfac41d7dc7486cd785dedb426750c56ab172e3407a7eebb8f30043fc5edc4b5848d802a6d149b29ab74fd83941a48307ea959c180836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21bb6ae9b69459b30e83811bda3a9eaa012493528b4bc6c43a69360c0859159d35793ca7627fab425bfe38c2e09cd86225bbab84b4b68e1e6c6dea8cae5c52c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e321143708b1c46e212e243d3a2753bdf5bf0e18eca67d8e053d61941d3a2968e9b2f2aab3607dae038f0e2787c15c002539f6d503570d24eec1d4e4373546ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea4041fb82a30eda990d33d86eca520caa3cd9b3f6db8616d044784a6a58b7a5c33ea130c885f93c28666ac4f0734d3b95b003067a71b3e572af8b6c64e815ef"} build_url:https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011310 build_url: 'https://queue.taskcluster.net/v1/task/RR5fTWcKQL-yAdPzCsoeOA/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/563daa76d7d00faa673dfac41d7dc7486cd785dedb426750c56ab172e3407a7eebb8f30043fc5edc4b5848d802a6d149b29ab74fd83941a48307ea959c180836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/21bb6ae9b69459b30e83811bda3a9eaa012493528b4bc6c43a69360c0859159d35793ca7627fab425bfe38c2e09cd86225bbab84b4b68e1e6c6dea8cae5c52c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/e321143708b1c46e212e243d3a2753bdf5bf0e18eca67d8e053d61941d3a2968e9b2f2aab3607dae038f0e2787c15c002539f6d503570d24eec1d4e4373546ca", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ea4041fb82a30eda990d33d86eca520caa3cd9b3f6db8616d044784a6a58b7a5c33ea130c885f93c28666ac4f0734d3b95b003067a71b3e572af8b6c64e815ef"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 08:19:26.130405) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:19:26.131033) ========= 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.tORX7AF2Rb/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.5PWqDDsrOL/Listeners TMPDIR=/var/folders/w2/w1z_phsd18j4ppkx071wqglm00000w/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.004809 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:19:26.180910) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 08:19:26.181255) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 08:19:26.181620) ========= ========= Total master_lag: 0.20 =========