builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0030 starttime: 1493826086.45 results: success (0) buildid: 20170503070220 builduid: 03021223bdc44d20a83a2f6a9a588ca4 revision: 80c0f82da68cc1e2fdb6e92e17b09f85a5068009 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:26.451004) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:26.451448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:26.451758) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:26.477103) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:26.477425) ========= 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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-05-03 08:41:26-- 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% 8.17M=0.001s 2017-05-03 08:41:26 (8.17 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.201267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:26.703079) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:26.703392) ========= 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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.022582 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:26.752862) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 08:41:26.753248) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 80c0f82da68cc1e2fdb6e92e17b09f85a5068009 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 80c0f82da68cc1e2fdb6e92e17b09f85a5068009 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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-05-03 08:41:26,827 truncating revision to first 12 chars 2017-05-03 08:41:26,828 Setting DEBUG logging. 2017-05-03 08:41:26,828 attempt 1/10 2017-05-03 08:41:26,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/80c0f82da68c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-03 08:41:28,460 unpacking tar archive at: mozilla-beta-80c0f82da68c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.894370 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-03 08:41:28.672147) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:28.672471) ========= script_repo_revision: 80c0f82da68cc1e2fdb6e92e17b09f85a5068009 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:28.672859) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:28.673122) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-03 08:41:28.693602) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-05-03 08:41:28.694024) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 08:41:28 INFO - MultiFileLogger online at 20170503 08:41:28 in /builds/slave/test 08:41:28 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:41:28 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:41:28 INFO - {'append_to_log': False, 08:41:28 INFO - 'base_work_dir': '/builds/slave/test', 08:41:28 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:41:28 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:41:28 INFO - 'branch': 'Mozilla-Beta', 08:41:28 INFO - 'buildbot_json_path': 'buildprops.json', 08:41:28 INFO - 'config_files': ('talos/mac_config.py',), 08:41:28 INFO - 'default_actions': ('clobber', 08:41:28 INFO - 'read-buildbot-config', 08:41:28 INFO - 'download-and-extract', 08:41:28 INFO - 'populate-webroot', 08:41:28 INFO - 'create-virtualenv', 08:41:28 INFO - 'install', 08:41:28 INFO - 'run-tests'), 08:41:28 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:41:28 INFO - 'download_minidump_stackwalk': True, 08:41:28 INFO - 'download_symbols': 'ondemand', 08:41:28 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:41:28 INFO - 'tooltool.py': '/tools/tooltool.py', 08:41:28 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:41:28 INFO - '/tools/misc-python/virtualenv.py')}, 08:41:28 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:41:28 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:41:28 INFO - 'gecko_profile': False, 08:41:28 INFO - 'gecko_profile_interval': 0, 08:41:28 INFO - 'installer_path': 'installer.exe', 08:41:28 INFO - 'log_level': 'info', 08:41:28 INFO - 'log_name': 'talos', 08:41:28 INFO - 'log_to_console': True, 08:41:28 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:41:28 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:41:28 INFO - 'opt_config_files': (), 08:41:28 INFO - 'pip_index': False, 08:41:28 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:41:28 INFO - 'cmd': ('bash', 08:41:28 INFO - '-c', 08:41:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:41:28 INFO - 'enabled': True, 08:41:28 INFO - 'halt_on_failure': False, 08:41:28 INFO - 'name': 'check_screen_resolution'},), 08:41:28 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:41:28 INFO - 'cmd': ('bash', 08:41:28 INFO - '-c', 08:41:28 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:41:28 INFO - 'enabled': True, 08:41:28 INFO - 'halt_on_failure': False, 08:41:28 INFO - 'name': 'check_screen_resolution'},), 08:41:28 INFO - 'run_cmd_checks_enabled': True, 08:41:28 INFO - 'suite': 'dromaeojs', 08:41:28 INFO - 'system_bits': '32', 08:41:28 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:41:28 INFO - 'title': 't-yosemite-r7-0030', 08:41:28 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:41:28 INFO - 'use_talos_json': True, 08:41:28 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:41:28 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:41:28 INFO - 'work_dir': 'build'} 08:41:28 INFO - [mozharness: 2017-05-03 15:41:28.897144Z] Running clobber step. 08:41:28 INFO - Running pre-action listener: _resource_record_pre_action 08:41:28 INFO - Running main action method: clobber 08:41:28 INFO - rmtree: /builds/slave/test/build 08:41:28 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:41:30 INFO - Running post-action listener: _resource_record_post_action 08:41:30 INFO - [mozharness: 2017-05-03 15:41:30.797314Z] Finished clobber step (success) 08:41:30 INFO - [mozharness: 2017-05-03 15:41:30.797454Z] Running read-buildbot-config step. 08:41:30 INFO - Running pre-action listener: _resource_record_pre_action 08:41:30 INFO - Running main action method: read_buildbot_config 08:41:30 INFO - Using buildbot properties: 08:41:30 INFO - { 08:41:30 INFO - "project": "", 08:41:30 INFO - "product": "firefox", 08:41:30 INFO - "script_repo_revision": "production", 08:41:30 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 08:41:30 INFO - "repository": "", 08:41:30 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 08:41:30 INFO - "buildid": "20170503070220", 08:41:30 INFO - "pgo_build": "False", 08:41:30 INFO - "basedir": "/builds/slave/test", 08:41:30 INFO - "buildnumber": 22, 08:41:30 INFO - "slavename": "t-yosemite-r7-0030", 08:41:30 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 08:41:30 INFO - "platform": "yosemite_r7", 08:41:30 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:41:30 INFO - "branch": "mozilla-beta", 08:41:30 INFO - "repo_path": "releases/mozilla-beta", 08:41:30 INFO - "revision": "80c0f82da68cc1e2fdb6e92e17b09f85a5068009", 08:41:30 INFO - "stage_platform": "macosx64", 08:41:30 INFO - "builduid": "03021223bdc44d20a83a2f6a9a588ca4", 08:41:30 INFO - "slavebuilddir": "test" 08:41:30 INFO - } 08:41:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 08:41:30 INFO - Running post-action listener: _resource_record_post_action 08:41:30 INFO - [mozharness: 2017-05-03 15:41:30.800653Z] Finished read-buildbot-config step (success) 08:41:30 INFO - [mozharness: 2017-05-03 15:41:30.800762Z] Running download-and-extract step. 08:41:30 INFO - Running pre-action listener: _resource_record_pre_action 08:41:30 INFO - Running main action method: download_and_extract 08:41:30 INFO - mkdir: /builds/slave/test/build/tests 08:41:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:41:30 INFO - trying https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 08:41:30 INFO - Downloading https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:41:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 08:41:32 INFO - Downloaded 1287 bytes. 08:41:32 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 08:41:32 INFO - Using the following test package requirements: 08:41:32 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:41:32 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 08:41:32 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:41:32 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:41:32 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 08:41:32 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:41:32 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 08:41:32 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:41:32 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:41:32 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 08:41:32 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 08:41:32 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:41:32 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 08:41:32 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:41:32 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 08:41:32 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:41:32 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 08:41:32 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 08:41:32 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 08:41:32 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 08:41:32 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:41:32 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:41:32 INFO - Fetch https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:41:33 INFO - Expected file size: 51222361 08:41:33 INFO - Obtained file size: 51222361 08:41:49 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:41:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 08:41:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 08:41:49 INFO - Fetch https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 08:41:51 INFO - Expected file size: 51222361 08:41:51 INFO - Obtained file size: 51222361 08:42:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 08:42:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 08:42:06 INFO - Fetch https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 08:42:07 INFO - Expected file size: 14404449 08:42:07 INFO - Obtained file size: 14404449 08:42:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:07 INFO - trying https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:42:07 INFO - Downloading https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 08:42:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 08:42:09 INFO - Downloaded 59544241 bytes. 08:42:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:42:09 INFO - mkdir: /builds/slave/test/properties 08:42:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:09 INFO - Contents: 08:42:09 INFO - build_url:https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 08:42:09 INFO - Running post-action listener: _resource_record_post_action 08:42:09 INFO - Running post-action listener: set_extra_try_arguments 08:42:09 INFO - [mozharness: 2017-05-03 15:42:09.840197Z] Finished download-and-extract step (success) 08:42:09 INFO - [mozharness: 2017-05-03 15:42:09.840318Z] Running populate-webroot step. 08:42:09 INFO - Running pre-action listener: _resource_record_pre_action 08:42:09 INFO - Running main action method: populate_webroot 08:42:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:09 INFO - '--tppagecycles', 08:42:09 INFO - '7'], 08:42:09 INFO - 'tests': ['tsvgm']}}, 08:42:09 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:09 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:09 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:09 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:09 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:42:09 INFO - 'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:09 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:42:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:09 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:42:09 INFO - 'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['damp', 'tps']}, 08:42:09 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:42:09 INFO - 'tests': ['damp', 'tps']}, 08:42:09 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['dromaeo_dom']}, 08:42:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:09 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['basic_compositor_video']}, 08:42:09 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:42:09 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['a11yr', 08:42:09 INFO - 'ts_paint', 08:42:09 INFO - 'tpaint', 08:42:09 INFO - 'sessionrestore', 08:42:09 INFO - 'sessionrestore_no_auto_restore', 08:42:09 INFO - 'tabpaint']}, 08:42:09 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:09 INFO - 'ts_paint', 08:42:09 INFO - 'tpaint', 08:42:09 INFO - 'sessionrestore', 08:42:09 INFO - 'sessionrestore_no_auto_restore', 08:42:09 INFO - 'tabpaint']}, 08:42:09 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:09 INFO - 'ts_paint', 08:42:09 INFO - 'tpaint', 08:42:09 INFO - 'sessionrestore', 08:42:09 INFO - 'sessionrestore_no_auto_restore', 08:42:09 INFO - 'tabpaint']}, 08:42:09 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:09 INFO - 'ts_paint', 08:42:09 INFO - 'tpaint', 08:42:09 INFO - 'sessionrestore', 08:42:09 INFO - 'sessionrestore_no_auto_restore', 08:42:09 INFO - 'tabpaint']}, 08:42:09 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['a11yr', 08:42:09 INFO - 'ts_paint', 08:42:09 INFO - 'tpaint', 08:42:09 INFO - 'sessionrestore', 08:42:09 INFO - 'sessionrestore_no_auto_restore', 08:42:09 INFO - 'tabpaint']}, 08:42:09 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['a11yr', 08:42:09 INFO - 'ts_paint', 08:42:09 INFO - 'tpaint', 08:42:09 INFO - 'sessionrestore', 08:42:09 INFO - 'sessionrestore_no_auto_restore', 08:42:09 INFO - 'tabpaint']}, 08:42:09 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['tsvgx', 08:42:09 INFO - 'tsvgr_opacity', 08:42:09 INFO - 'tart', 08:42:09 INFO - 'tscrollx', 08:42:09 INFO - 'cart', 08:42:09 INFO - 'tsvg_static']}, 08:42:09 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:09 INFO - 'tsvgr_opacity', 08:42:09 INFO - 'tart', 08:42:09 INFO - 'tscrollx', 08:42:09 INFO - 'cart', 08:42:09 INFO - 'tsvg_static']}, 08:42:09 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:42:09 INFO - 'talos_options': ['--disable-e10s'], 08:42:09 INFO - 'tests': ['tp5o']}, 08:42:09 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:42:09 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:42:09 INFO - 'talos_options': ['--disable-e10s', 08:42:09 INFO - '--xperf_path', 08:42:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:09 INFO - 'tests': ['tp5n']}, 08:42:09 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:42:09 INFO - 'talos_options': ['--xperf_path', 08:42:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:09 INFO - 'tests': ['tp5n']}}, 08:42:09 INFO - 'talos.zip': {'path': '', 08:42:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:09 INFO - Running post-action listener: _resource_record_post_action 08:42:09 INFO - [mozharness: 2017-05-03 15:42:09.858615Z] Finished populate-webroot step (success) 08:42:09 INFO - [mozharness: 2017-05-03 15:42:09.858754Z] Running create-virtualenv step. 08:42:09 INFO - Running pre-action listener: _resource_record_pre_action 08:42:09 INFO - Running main action method: create_virtualenv 08:42:09 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:09 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:42:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:09 INFO - Using real prefix '/tools/python27' 08:42:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:10 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:13 INFO - Installing pip.................done. 08:42:13 INFO - Return code: 0 08:42:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:42:13 INFO - Reading from file tmpfile_stdout 08:42:13 INFO - Output received: 08:42:13 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:42:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:13 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 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:42:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:14 INFO - 'HOME': '/Users/cltbld', 08:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:14 INFO - 'LOGNAME': 'cltbld', 08:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:14 INFO - 'MOZ_NO_REMOTE': '1', 08:42:14 INFO - 'NO_EM_RESTART': '1', 08:42:14 INFO - 'PAGER': '/bin/cat', 08:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:14 INFO - 'PWD': '/builds/slave/test', 08:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:14 INFO - 'SHELL': '/bin/bash', 08:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:14 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:14 INFO - 'USER': 'cltbld', 08:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:14 INFO - 'XPC_FLAGS': '0x0', 08:42:14 INFO - 'XPC_SERVICE_NAME': '0', 08:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:14 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:42:14 INFO - Cleaning up... 08:42:14 INFO - Return code: 0 08:42:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:14 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 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:42:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:14 INFO - 'HOME': '/Users/cltbld', 08:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:14 INFO - 'LOGNAME': 'cltbld', 08:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:14 INFO - 'MOZ_NO_REMOTE': '1', 08:42:14 INFO - 'NO_EM_RESTART': '1', 08:42:14 INFO - 'PAGER': '/bin/cat', 08:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:14 INFO - 'PWD': '/builds/slave/test', 08:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:14 INFO - 'SHELL': '/bin/bash', 08:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:14 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:14 INFO - 'USER': 'cltbld', 08:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:14 INFO - 'XPC_FLAGS': '0x0', 08:42:14 INFO - 'XPC_SERVICE_NAME': '0', 08:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:14 INFO - Downloading/unpacking psutil>=3.1.1 08:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:16 INFO - Installing collected packages: psutil 08:42:16 INFO - Running setup.py install for psutil 08:42:16 INFO - building 'psutil._psutil_osx' extension 08:42:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:42:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:42:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:42:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:42:17 INFO - building 'psutil._psutil_posix' extension 08:42:17 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:42:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:42:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:42:17 INFO - ^ 08:42:17 INFO - 1 warning generated. 08:42:17 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:42:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:17 INFO - Successfully installed psutil 08:42:17 INFO - Cleaning up... 08:42:17 INFO - Return code: 0 08:42:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:17 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 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:42:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:42:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:17 INFO - 'HOME': '/Users/cltbld', 08:42:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:17 INFO - 'LOGNAME': 'cltbld', 08:42:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:17 INFO - 'MOZ_NO_REMOTE': '1', 08:42:17 INFO - 'NO_EM_RESTART': '1', 08:42:17 INFO - 'PAGER': '/bin/cat', 08:42:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:17 INFO - 'PWD': '/builds/slave/test', 08:42:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:17 INFO - 'SHELL': '/bin/bash', 08:42:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:17 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:17 INFO - 'USER': 'cltbld', 08:42:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:17 INFO - 'XPC_FLAGS': '0x0', 08:42:17 INFO - 'XPC_SERVICE_NAME': '0', 08:42:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:19 INFO - Installing collected packages: mozsystemmonitor 08:42:19 INFO - Running setup.py install for mozsystemmonitor 08:42:19 INFO - Successfully installed mozsystemmonitor 08:42:19 INFO - Cleaning up... 08:42:19 INFO - Return code: 0 08:42:19 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42: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==2.5.1'] in /builds/slave/test/build 08:42: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==2.5.1 08:42:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:19 INFO - 'HOME': '/Users/cltbld', 08:42:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:19 INFO - 'LOGNAME': 'cltbld', 08:42:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:19 INFO - 'MOZ_NO_REMOTE': '1', 08:42:19 INFO - 'NO_EM_RESTART': '1', 08:42:19 INFO - 'PAGER': '/bin/cat', 08:42:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:19 INFO - 'PWD': '/builds/slave/test', 08:42:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:19 INFO - 'SHELL': '/bin/bash', 08:42:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:19 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:19 INFO - 'USER': 'cltbld', 08:42:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:19 INFO - 'XPC_FLAGS': '0x0', 08:42:19 INFO - 'XPC_SERVICE_NAME': '0', 08:42:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:19 INFO - Downloading/unpacking jsonschema==2.5.1 08:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:21 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:21 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:21 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:21 INFO - warning: no files found matching '*.txt' 08:42:21 INFO - no previously-included directories found matching 'build' 08:42:21 INFO - no previously-included directories found matching 'dist' 08:42:21 INFO - no previously-included directories found matching '.git*' 08:42:21 INFO - Installing collected packages: jsonschema, functools32 08:42:21 INFO - Running setup.py install for functools32 08:42:21 INFO - warning: no files found matching '*.txt' 08:42:21 INFO - no previously-included directories found matching 'build' 08:42:21 INFO - no previously-included directories found matching 'dist' 08:42:21 INFO - no previously-included directories found matching '.git*' 08:42:21 INFO - Successfully installed jsonschema functools32 08:42:21 INFO - Cleaning up... 08:42:21 INFO - Return code: 0 08:42:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:22 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 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:42:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:42:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:22 INFO - 'HOME': '/Users/cltbld', 08:42:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:22 INFO - 'LOGNAME': 'cltbld', 08:42:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:22 INFO - 'MOZ_NO_REMOTE': '1', 08:42:22 INFO - 'NO_EM_RESTART': '1', 08:42:22 INFO - 'PAGER': '/bin/cat', 08:42:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:22 INFO - 'PWD': '/builds/slave/test', 08:42:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:22 INFO - 'SHELL': '/bin/bash', 08:42:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:22 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:22 INFO - 'USER': 'cltbld', 08:42:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:22 INFO - 'XPC_FLAGS': '0x0', 08:42:22 INFO - 'XPC_SERVICE_NAME': '0', 08:42:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:22 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:22 INFO - Cleaning up... 08:42:22 INFO - Return code: 0 08:42:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:23 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 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:42:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:23 INFO - 'HOME': '/Users/cltbld', 08:42:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:23 INFO - 'LOGNAME': 'cltbld', 08:42:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:23 INFO - 'MOZ_NO_REMOTE': '1', 08:42:23 INFO - 'NO_EM_RESTART': '1', 08:42:23 INFO - 'PAGER': '/bin/cat', 08:42:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:23 INFO - 'PWD': '/builds/slave/test', 08:42:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:23 INFO - 'SHELL': '/bin/bash', 08:42:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:23 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:23 INFO - 'USER': 'cltbld', 08:42:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:23 INFO - 'XPC_FLAGS': '0x0', 08:42:23 INFO - 'XPC_SERVICE_NAME': '0', 08:42:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:23 INFO - Downloading/unpacking blobuploader==1.2.4 08:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:25 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:26 INFO - Downloading docopt-0.6.1.tar.gz 08:42:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:26 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:26 INFO - Running setup.py install for blobuploader 08:42:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:26 INFO - Running setup.py install for requests 08:42:26 INFO - Running setup.py install for docopt 08:42:27 INFO - Successfully installed blobuploader requests docopt 08:42:27 INFO - Cleaning up... 08:42:27 INFO - Return code: 0 08:42:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:27 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 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:27 INFO - 'HOME': '/Users/cltbld', 08:42:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:27 INFO - 'LOGNAME': 'cltbld', 08:42:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:27 INFO - 'MOZ_NO_REMOTE': '1', 08:42:27 INFO - 'NO_EM_RESTART': '1', 08:42:27 INFO - 'PAGER': '/bin/cat', 08:42:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:27 INFO - 'PWD': '/builds/slave/test', 08:42:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:27 INFO - 'SHELL': '/bin/bash', 08:42:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:27 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:27 INFO - 'USER': 'cltbld', 08:42:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:27 INFO - 'XPC_FLAGS': '0x0', 08:42:27 INFO - 'XPC_SERVICE_NAME': '0', 08:42:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-UgRcoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-kcBagp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-wniLJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Ix1HCR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-PXm2UB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:27 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-oG33lp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Y6Zyi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-Wj4CV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-rSxcAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-N9pyYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-oHfgHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-vkafgu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-guXFHT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-8c3jwV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:28 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-AiHIzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-pitpb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:29 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-R63YRN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:29 INFO - Running setup.py install for manifestparser 08:42:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Running setup.py install for mozcrash 08:42:29 INFO - Running setup.py install for mozdebug 08:42:29 INFO - Running setup.py install for mozdevice 08:42:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:29 INFO - Running setup.py install for mozfile 08:42:30 INFO - Running setup.py install for mozhttpd 08:42:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:30 INFO - Running setup.py install for mozinfo 08:42:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:30 INFO - Running setup.py install for mozInstall 08:42:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:30 INFO - Running setup.py install for mozleak 08:42:30 INFO - Running setup.py install for mozlog 08:42:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:30 INFO - Running setup.py install for moznetwork 08:42:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:30 INFO - Running setup.py install for mozprocess 08:42:31 INFO - Running setup.py install for mozprofile 08:42:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:31 INFO - Running setup.py install for mozrunner 08:42:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:31 INFO - Running setup.py install for mozscreenshot 08:42:31 INFO - Running setup.py install for moztest 08:42:31 INFO - Running setup.py install for mozversion 08:42:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:31 INFO - Cleaning up... 08:42:31 INFO - Return code: 0 08:42:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:31 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 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:31 INFO - 'HOME': '/Users/cltbld', 08:42:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:31 INFO - 'LOGNAME': 'cltbld', 08:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:31 INFO - 'MOZ_NO_REMOTE': '1', 08:42:31 INFO - 'NO_EM_RESTART': '1', 08:42:31 INFO - 'PAGER': '/bin/cat', 08:42:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:31 INFO - 'PWD': '/builds/slave/test', 08:42:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:31 INFO - 'SHELL': '/bin/bash', 08:42:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:31 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:31 INFO - 'USER': 'cltbld', 08:42:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:31 INFO - 'XPC_FLAGS': '0x0', 08:42:31 INFO - 'XPC_SERVICE_NAME': '0', 08:42:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-cjCQN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-YvIZ8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-TwPQ_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-MtQZ9W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-XCh6dw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-efhkz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-wPBcy4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-bIDK8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:42:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:32 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-BQLnDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-6lTO2K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-7heKXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-gaJDsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-jprm64-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-CIF0yg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-A5MvFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-6czLay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:42:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:33 INFO - Running setup.py (path:/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/pip-mnkiIp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:33 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:35 INFO - Downloading blessings-1.6.tar.gz 08:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:35 INFO - Installing collected packages: blessings 08:42:35 INFO - Running setup.py install for blessings 08:42:35 INFO - Successfully installed blessings 08:42:35 INFO - Cleaning up... 08:42:35 INFO - Return code: 0 08:42:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:35 INFO - Reading from file tmpfile_stdout 08:42:35 INFO - Current package versions: 08:42:35 INFO - blessings == 1.6 08:42:35 INFO - blobuploader == 1.2.4 08:42:35 INFO - docopt == 0.6.1 08:42:35 INFO - functools32 == 3.2.3-2 08:42:35 INFO - jsonschema == 2.5.1 08:42:35 INFO - manifestparser == 1.1 08:42:35 INFO - mozInstall == 1.12 08:42:35 INFO - mozcrash == 1.0 08:42:35 INFO - mozdebug == 0.1 08:42:35 INFO - mozdevice == 0.49 08:42:35 INFO - mozfile == 1.2 08:42:35 INFO - mozhttpd == 0.7 08:42:35 INFO - mozinfo == 0.9 08:42:35 INFO - mozleak == 0.1 08:42:35 INFO - mozlog == 3.4 08:42:35 INFO - moznetwork == 0.27 08:42:35 INFO - mozprocess == 0.25 08:42:35 INFO - mozprofile == 0.28 08:42:35 INFO - mozrunner == 6.13 08:42:35 INFO - mozscreenshot == 0.1 08:42:35 INFO - mozsystemmonitor == 0.3 08:42:35 INFO - moztest == 0.8 08:42:35 INFO - mozversion == 1.4 08:42:35 INFO - psutil == 3.1.1 08:42:35 INFO - requests == 1.2.3 08:42:35 INFO - wsgiref == 0.1.2 08:42:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:35 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 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:42:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:35 INFO - 'HOME': '/Users/cltbld', 08:42:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:35 INFO - 'LOGNAME': 'cltbld', 08:42:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:35 INFO - 'MOZ_NO_REMOTE': '1', 08:42:35 INFO - 'NO_EM_RESTART': '1', 08:42:35 INFO - 'PAGER': '/bin/cat', 08:42:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:35 INFO - 'PWD': '/builds/slave/test', 08:42:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:35 INFO - 'SHELL': '/bin/bash', 08:42:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:35 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:35 INFO - 'USER': 'cltbld', 08:42:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:35 INFO - 'XPC_FLAGS': '0x0', 08:42:35 INFO - 'XPC_SERVICE_NAME': '0', 08:42:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:36 INFO - Cleaning up... 08:42:36 INFO - Return code: 0 08:42:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103992b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103995768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff922465380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, '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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 08:42:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:36 INFO - 'HOME': '/Users/cltbld', 08:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:36 INFO - 'LOGNAME': 'cltbld', 08:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:36 INFO - 'MOZ_NO_REMOTE': '1', 08:42:36 INFO - 'NO_EM_RESTART': '1', 08:42:36 INFO - 'PAGER': '/bin/cat', 08:42:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:36 INFO - 'PWD': '/builds/slave/test', 08:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:36 INFO - 'SHELL': '/bin/bash', 08:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:36 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:36 INFO - 'USER': 'cltbld', 08:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:36 INFO - 'XPC_FLAGS': '0x0', 08:42:36 INFO - 'XPC_SERVICE_NAME': '0', 08:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:36 INFO - Cleaning up... 08:42:36 INFO - Return code: 0 08:42:36 INFO - Running post-action listener: _resource_record_post_action 08:42:36 INFO - Running post-action listener: _start_resource_monitoring 08:42:36 INFO - Starting resource monitoring. 08:42:36 INFO - [mozharness: 2017-05-03 15:42:36.482424Z] Finished create-virtualenv step (success) 08:42:36 INFO - [mozharness: 2017-05-03 15:42:36.483505Z] Running install step. 08:42:36 INFO - Running pre-action listener: _resource_record_pre_action 08:42:36 INFO - Running main action method: install 08:42:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:36 INFO - Reading from file tmpfile_stdout 08:42:36 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:36 INFO - Reading from file tmpfile_stdout 08:42:36 INFO - Output received: 08:42:36 INFO - Usage: mozinstall [options] installer 08:42:36 INFO - Options: 08:42:36 INFO - -h, --help show this help message and exit 08:42:36 INFO - -d DEST, --destination=DEST 08:42:36 INFO - Directory to install application into. [default: 08:42:36 INFO - "/builds/slave/test"] 08:42:36 INFO - --app=APP Application being installed. [default: firefox] 08:42:36 INFO - mkdir: /builds/slave/test/build/application 08:42:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:42:51 INFO - Reading from file tmpfile_stdout 08:42:51 INFO - Output received: 08:42:51 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:42:51 INFO - Running post-action listener: _resource_record_post_action 08:42:51 INFO - [mozharness: 2017-05-03 15:42:51.620889Z] Finished install step (success) 08:42:51 INFO - [mozharness: 2017-05-03 15:42:51.621032Z] Running run-tests step. 08:42:51 INFO - Running pre-action listener: _resource_record_pre_action 08:42:51 INFO - Running main action method: run_tests 08:42:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:42:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:42:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:42:51 INFO - 2017-05-03 08:42:51.634 screenresolution[3260:50212] starting screenresolution argv=screenresolution get 08:42:51 INFO - 2017-05-03 08:42:51.637 screenresolution[3260:50212] Display 0: 1600x1200x32@60 08:42:51 INFO - 2017-05-03 08:42:51.642 screenresolution[3261:50214] starting screenresolution argv=screenresolution list 08:42:51 INFO - Available Modes on Display 0 08:42:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:42:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:42:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:42:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:42:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:42:51 INFO - Intel Iris: 08:42:51 INFO - Chipset Model: Intel Iris 08:42:51 INFO - Type: GPU 08:42:51 INFO - Bus: Built-In 08:42:51 INFO - VRAM (Dynamic, Max): 1536 MB 08:42:51 INFO - Vendor: Intel (0x8086) 08:42:51 INFO - Device ID: 0x0a2e 08:42:51 INFO - Revision ID: 0x0009 08:42:51 INFO - Displays: 08:42:51 INFO - Display: 08:42:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:42:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:42:51 INFO - Display Serial Number: 1600x1200 60 08:42:51 INFO - Main Display: Yes 08:42:51 INFO - Mirror: Off 08:42:51 INFO - Online: Yes 08:42:51 INFO - Rotation: Supported 08:42:51 INFO - Return code: 0 08:42:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:42:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:42:51 INFO - Python 2.7.3 08:42:51 INFO - Return code: 0 08:42:51 INFO - grabbing minidump binary from tooltool 08:42:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:51 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 0x103770d30>, '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 0x103697db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103765be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:42:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:42:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 08:42:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:42:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:42:52 INFO - Return code: 0 08:42:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:42:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:42:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:42:52 INFO - ENV: RUST_BACKTRACE is now 1 08:42:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:42:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:42:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0030 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:42:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UBzwQ8VXf2/Render', 08:42:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:42:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:42:52 INFO - 'HOME': '/Users/cltbld', 08:42:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:42:52 INFO - 'LOGNAME': 'cltbld', 08:42:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:42:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:42:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:52 INFO - 'MOZ_NO_REMOTE': '1', 08:42:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:42:52 INFO - 'NO_EM_RESTART': '1', 08:42:52 INFO - 'PAGER': '/bin/cat', 08:42:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:42:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:52 INFO - 'PWD': '/builds/slave/test', 08:42:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:42:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:42:52 INFO - 'RUST_BACKTRACE': '1', 08:42:52 INFO - 'SHELL': '/bin/bash', 08:42:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.BsNXkWrKc8/Listeners', 08:42:52 INFO - 'TMPDIR': '/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/', 08:42:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:42:52 INFO - 'USER': 'cltbld', 08:42:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:42:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:42:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:52 INFO - 'XPC_FLAGS': '0x0', 08:42:52 INFO - 'XPC_SERVICE_NAME': '0', 08:42:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:42:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0030', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:42:52 INFO - mozversion application_buildid: 20170503070220 08:42:52 INFO - mozversion application_changeset: 80c0f82da68cc1e2fdb6e92e17b09f85a5068009 08:42:52 INFO - mozversion application_display_name: Firefox 08:42:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:42:52 INFO - mozversion application_name: Firefox 08:42:52 INFO - mozversion application_remotingname: firefox 08:42:52 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:42:52 INFO - mozversion application_vendor: Mozilla 08:42:52 INFO - mozversion application_version: 54.0 08:42:52 INFO - mozversion platform_buildid: 20170503070220 08:42:52 INFO - mozversion platform_changeset: 80c0f82da68cc1e2fdb6e92e17b09f85a5068009 08:42:52 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:42:52 INFO - mozversion platform_version: 54.0 08:42:52 INFO - using testdate: 1493826172 08:42:52 INFO - actual date: 1493826172 08:42:52 INFO - starting webserver on 'localhost:65143' 08:42:52 INFO - SUITE-START | Running 2 tests 08:42:52 INFO - TEST-START | dromaeo_css 08:42:52 INFO - operating with platform_type : mac_ 08:42:52 INFO - Initialising browser for dromaeo_css test... 08:42:52 INFO - TEST-INFO | started process 3271 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpgL5GPO/profile http://localhost:65143/getInfo.html) 08:42:54 INFO - PROCESS | 3271 | __metrics Screen width/height:1600/1200 08:42:54 INFO - PROCESS | 3271 | colorDepth:24 08:42:54 INFO - PROCESS | 3271 | Browser inner width/height: 1024/689 08:42:54 INFO - PROCESS | 3271 | __metrics 08:42:54 INFO - PROCESS | 3271 | 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:42:54 INFO - PROCESS | 3271 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:42:55 INFO - TEST-INFO | 3271: exit 0 08:42:55 INFO - Browser initialized. 08:42:55 INFO - Running cycle 1/1 for dromaeo_css test... 08:42:55 INFO - TEST-INFO | started process 3274 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmpgL5GPO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:07 INFO - PROCESS | 3274 | RSS: Main: 169349120 08:43:07 INFO - PROCESS | 3274 | 08:46:10 INFO - PROCESS | 3274 | Cycle 1(1): loaded http://localhost:65143/tests/dromaeo/cssquery-dojo.html (next: http://localhost:65143/tests/dromaeo/cssquery-ext.html) 08:46:12 INFO - PROCESS | 3274 | RSS: Main: 343846912 08:46:12 INFO - PROCESS | 3274 | 08:49:15 INFO - PROCESS | 3274 | Cycle 1(1): loaded http://localhost:65143/tests/dromaeo/cssquery-ext.html (next: http://localhost:65143/tests/dromaeo/cssquery-jquery.html) 08:49:16 INFO - PROCESS | 3274 | RSS: Main: 302264320 08:49:16 INFO - PROCESS | 3274 | 08:52:18 INFO - PROCESS | 3274 | Cycle 1(1): loaded http://localhost:65143/tests/dromaeo/cssquery-jquery.html (next: http://localhost:65143/tests/dromaeo/cssquery-mootools.html) 08:52:19 INFO - PROCESS | 3274 | RSS: Main: 269074432 08:52:19 INFO - PROCESS | 3274 | 08:55:21 INFO - PROCESS | 3274 | Cycle 1(1): loaded http://localhost:65143/tests/dromaeo/cssquery-mootools.html (next: http://localhost:65143/tests/dromaeo/cssquery-prototype.html) 08:55:22 INFO - PROCESS | 3274 | RSS: Main: 272052224 08:55:22 INFO - PROCESS | 3274 | 08:58:25 INFO - PROCESS | 3274 | Cycle 1(1): loaded http://localhost:65143/tests/dromaeo/cssquery-prototype.html (next: http://localhost:65143/tests/dromaeo/cssquery-yui.html) 08:58:26 INFO - PROCESS | 3274 | RSS: Main: 262897664 08:58:26 INFO - PROCESS | 3274 | 09:01:29 INFO - PROCESS | 3274 | Cycle 1(1): loaded http://localhost:65143/tests/dromaeo/cssquery-yui.html (next: http://localhost:65143/tests/dromaeo/cssquery-dojo.html) 09:01:30 INFO - PROCESS | 3274 | RSS: Main: 369823744 09:01:30 INFO - PROCESS | 3274 | 09:01:30 INFO - PROCESS | 3274 | __start_tp_report 09:01:30 INFO - PROCESS | 3274 | _x_x_mozilla_page_load 09:01:30 INFO - PROCESS | 3274 | _x_x_mozilla_page_load_details 09:01:30 INFO - PROCESS | 3274 | |i|pagename|runs| 09:01:30 INFO - PROCESS | 3274 | |0;dojo.html;2554.87225638718;3444.431668774653;3470.4794280857855;3473.930521389571;3497.1956450016496;5831.329397119327;5876.236089308384;5899.469047785698;5903.911441328372;5909.822705318842;5900.380460051697;5943.821685349447;5951.345352011275;5965;5974.910376344347;5221.765020574065;5227.32044834171;5240;5259.105951988152;5343.465653434664;5171.50870667286;5182.714950677711;5206.609504287175;5344.118220493614;5347.893042139155;5275.973620131894;5298.549623282026;5307.734613269321;5314.043472175007;5328.120860058086;5302.6023048271345;5310.256564081032;5331.2003199519995;5336.146216605344;5346.438623944468;5113.2330150477355;5210.921836172461;5266.8419947401635;5278.524932756032;5308.203769434577;5760.423957604248;5769.480746732815;5779.537636989031;5783.450572195635;5797.652140871562;6201.906971395432;6209.3790620938;6251.187345645082;6265.279492858334;6287.748490060392;6279.466245369149;6309.211348581427;6312.779052733133;6321.24145102586;6343.27052388972;6007.459328660398;6013.849653758691;6014.1580178775;6017.7592896284095;6070;6224.688765561704;6345.206849143857;6390;6417.7753778617525;6428.5178611604315;6188.938110618927;6256.468200202943;6260.186175797208;6289.654069026247;6311.526635502356;6329.493640508748;6344.206974128234;6347.39699728525;6357.332480089616;6372.36276372359;6282;6285.277193122758;6297.4017468340435;6313.715882785285;6325.146105275729;6160.476359509492;6202.4107709768405;6235.906461403082;6267.9373206268265;6272.18461599989;5061.746912654353;5062.190049592047;5062.670926389773;5089.694618322838;5096.541311282002;4518.819247230074;4532.410786597788;4549.226631472658;4573.839915602938;4585.220512512881;5787.479126878601;5898.026825573732;5928.644281343133;6096.9893995752245;6143.907841382383;6243.43809057178;6257.936150854366;6264.874702506016;6309.747610095636;6334.651594162273;6026.0659597762415;6030.517558595389;6063.454289114001;6078.817635470943;6097.359777223416;5466.890662186734;5526.972365138148;5537.335519737658;5552.472515111058;5552.7223638817895;6263.937360626335;6312.958361870332;6350.206224221973;6359.300476947625;6360.109584658244;6261.186045814015;6265.49876009909;6295.559310848196;6297.559170857996;6315.873682526232;6471.611703297817;6508.381703738138;6515.934840651533;6524.151860258136;6546.967265163644;6305.085762564494;6309.905351419824;6315.4947604192475;6320.209973753281;6350.110984462087;6206.193194884636;6239.812805615838;6270.561060725888;6305.369463053658;6305.96847015762;5074.517920797518;6243.313235543996;6258.405451482102;6282.2147231596055;6284.937150628618;5742.310922689304;6206.441420272197;6255.843603909757;6289.433950944437;6294.15028971083;5280.551153152025;5900.645961242168;5911.940880591139;6155.815325540241;6174.783882564088;6075.939240607538;6161.045038019114;6201.503879689524;6275.6862156892885;6294;5983.970080149571;5986.491148252448;6104.236970378703;6107.5760588585135;6142.955697531341 09:01:30 INFO - PROCESS | 3274 | |1;ext.html;746.5259560179288;811.9188081191879;828.755517122449;901.2654686430559;907.5008745190144;30010.099697009096;30426;40962.97592560187;41408.79295603518;43505.564944350546;41934.58065419345;42360.36459453111;42431.51489697861;42476.36285455721;42503.57496425035;9510.144087032166;9675.516224188797;9694;9696.515174241295;9726.17327527161;7915.366770658334;8031.799205019863;9549.809003819919;11671.883281167164;11775.823362649568;11735.295882247092;11830.526778928832;11832.585859494919;11860.110491713112;11867.406629668525;11764.352960587164;11784.292942423397;11787.88212117885;11788.292702437795;11816.58641947532;9974.202063834948;11181.608643697431;11418.828717569244;11464.713382165513;11483;34845.82577087123;37117;39515;39718;39819;3941.6649584785328;3989.780562069085;3998.2203470323007;4003.319435695939;4083.060895993908;28045.719542804516;30041.94853180128;30623.846880765454;30701.539476907863;30742.077737667907;3070.508718605035;3254.1864533866533;3261.869525218988;3278.1312952067483;3422.469517224834;313996;315717;315984;316100.4194979033;316622.41688791406;50940.981180376184;50944.74527627338;51015.74492127515;51071;51101.744491277306;53762.7311863446;53778.73110634422;53841.73079134579;53859;53898.730506347216;15082.095074295357;15450;15455.227238638023;15467.690646187239;15478.9226053869;13220.867791322156;13229.73540529184;13235.205887646773;13263.602091937257;13277;10547.156227501782;10740.355578665305;10815.729606759895;12016;12143.514259429523;4912.287718280901;5474.631342164459;5493.533049690821;5588.413216612197;5631.8592035199445;1087.2389327470644;1118.681175864891;1125.2573301620891;1148.9885101149048;1190.9166358355005;27837.860810696224;28053.62958818704;28265.71734282672;28341;28359.57460638092;1191.7199458127334;1199.4902166579168;1236.190295356543;1241.025794751134;1244.6888277930518;14244.572662819925;14389.28053597316;14443.916706247073;14760.114393136446;14798.630034249014;461245;469631;469691;470134.94797578064;470775;45647.31529027067;46382.53617463782;57031.71484142636;57423;57432.42567574354;1420.566727148209;1526.8472303411077;1533.3406635146994;1540.1144342003392;1545.3895711194016;29279.85360073186;30272.394552108395;30776.23059423443;30818.44495458557;31061.223469413446;37286.62713372832;38574.2285154301;47330.52669473261;47404.288935666686;47438.576842694776;478974;481761;482183;492308;605896;34268.48597271093;34544;34634;34801.82599086988;34835.03902168344;35707;42739.78630106829;43865.34201987037;44362.556374435844;45075.774621126686;27979.160625181277;28321.575176372782;29377.412451751272;29443.705562944095;30089.247768805955;29089.854550727112;29181.416371672873;29212.123636290944;29254.41491170122;29347;33368;33879;34124.82937585296;34173.658263418045;34297.82851085729;28664;28818.711812881604;29155.85422072876;29618.259543511584;29774;22050.8974551275;23283.301500955;23620.291391258288;23727.881360593776;23755.643665344687 09:01:30 INFO - PROCESS | 3274 | |2;jquery.html;382.707228969838;423.6907057847773;427.2992292640069;437.42260216514194;463.147808033219;18165.364212252574;20373.694394584076;21077;22374.216902408418;22535.887320563415;22710.545789084208;23596.764032359715;24024.75975240247;24257.39356516088;24391.878040609816;6899.517033807623;7046.1192350956135;7115.039469671606;7166.498345115844;7172.964135179317;6793.6603169841555;6888.10454640896;7036.050133231999;7042.2605626409;7055.259197784236;7035.613041282727;7065.7880263591915;7518.248175182493;7793.688252469923;7885.96057019717;7640.197779233156;7817.843643127134;7861.56761378124;7966.243206895336;7996.360291176721;7576.9621151894435;7622.618869056525;7681.116671582728;7694.076710794685;7705.730299439549;27696.446071078666;27918.302042448897;28191.436171276666;28492.002779902603;28593.285167870763;3028.1067085209916;3103.587867520273;3116.06518044588;3139.623245210589;3149.3228955774616;16368.590785230346;16479.423220187356;16898;17105.657886842317;17460.039697816614;2110.4407332057017;2117.6188286108495;2145.324222869791;2147.3235930681785;2261.31030035839;98264;118817.62364752656;170942;172946;173767.13116434464;18278.360257391192;19027.048647567568;20001.699974500105;20803.37589872306;20905.686414703487;33145.337093258;33344.66655333416;33710.32579348399;33734.325313493595;33753.987380378625;10819.080378167786;11075.224734268684;11108.666739997812;11158.218924675357;11351.318920864775;9195.816083678288;9218.492982885871;9229.584668689926;9455.385399948982;9459.76350591227;9418.656165395028;9685.610036487315;9755.926848046709;9762.46306453152;9772.9022709772;2475.876206189683;3807.276617442677;3863.8840834775;3876.5541962674088;3879.3599056155417;995.9850602240972;1011.327467234281;1057.9209206609216;1097.4786976186408;1105.247436025089;22476.662850057262;22662.886685566467;23012.769872301396;23053.654195187086;23071.53856922852;906.8005038891433;945.3713280668278;987.7629368951543;1024.1806554756165;1048.564845589072;8781.652654096913;11537.538498459968;11665.650030499099;11684.649460516028;11807.291562506278;632188;736273;796130;819215;819502;155753;156233;162277.18861405618;164797;168674.40965156598;1213.9635810925686;1307.4443361571293;1319.5843309357713;1369.5891232629972;1379.2276325257887;20671.8966405167;20836.895815520824;21293.6805947914;21337.466563336042;21420;56170.43829561652;63932.680336598016;64473.67763161154;64788.67605661941;65217;88900.66649000141;89204.5539772297;89644.55177724331;92127;92950.07049929685;9802.215822734022;11141.554337826721;11724;11765.411729413667;12074.698132546406;10497.47512624381;13095.476180953036;13499;13511.797323040359;13548.864511355154;10602.727672679328;10726.65560042601;11195.720106997065;11859.16985810985;11896.583619573274;10511.316764410289;10592.523336449724;10636.52135653913;10902.563897444013;11003.064739497233;11104.333739975627;11631.418429078343;11801.940990294994;11871.287722736663;11913.761724765629;11605.187636865337;11623.476943537393;11689.181757276909;11776.470058847544;12039.939800301292;9269.582868770787;10971.725706857393;11021.393823339793;11062.557497700001;11392.202545821712 09:01:30 INFO - PROCESS | 3274 | |3;mootools.html;1509.275547737086;1594.9282282297295;1605.1893793634213;1617.0459428936924;1622.789037425135;10955.99999999999;11645.941770291158;11646.126540509464;11652.533898644066;11674.766504669902;11099.5560177593;11368.09055275578;11388.202825802196;11647.534098636044;11675.416229188528;2041.7754047054812;2436.7806897379187;2467.6668649732237;2476.938076548083;2481.888315025828;2394.221877889684;2453.0678342229926;2474.8638824864624;2485.2047344849657;2488.8133389995824;2392.342105920868;2454;2469.370310570802;2479.665245191903;2481.0323973650293;2362.4330160761465;2427.9757202428013;2435.0016493237863;2440.8169387295848;2464.7658472445087;2421.9636705449434;2442.157455677806;2452.7424620414777;2455.472073504205;2462.064415522108;9321.766955826091;11501.252418592765;11513.251638643462;11513.654590362303;11514.194006419553;5883.911741323884;6076.359382966619;6083.513318934474;6089.665068421235;6109.969450152766;3583.2475180212186;3652.1052342176336;3675.026118078711;3721.1813401051727;3721.9069523261865;1224.9265044097383;1237.5359240284893;1283.9165454245444;1291.4446787881207;1313.1858247886275;14039.929800350932;14296.57110286693;14746.852531474655;15744.606384840356;15935.601609959727;4655.813767449264;4817.325574419584;4850.7873031742065;4856.101621200019;4870;10511.684649460529;12167.878321216851;12172.087093468026;12174;12190.963768079635;5135.768890399941;5817.7963771267805;5891.05743081105;5988;6030.427109424598;5241.449647786927;5384.434634363413;5420.728963551806;5467.0705979983495;5490.3411590609385;3324.3849887770357;3540.6282340354405;3804.087019115392;3949.229900169497;3978.224246272007;1034.110664828262;1036.6734478639355;1039.365986748083;1039.823230050878;1059.9841002384971;799.2447137455165;840.1598401598402;842.9884139033185;862.1895418306772;884.4472204871955;6801.727930882808;6845.247022827485;6902.413294869993;6982.581045137206;7061.505694601328;989.124624707125;1038.5015192707392;1041.7916416716687;1048.3238311289176;1058.8987453048896;4246.596573325529;4365.497967733688;4509.661775366795;4514.458265008155;4528.456585209796;13587.796183057262;14173.291335433187;14198.00613957013;14206.928965355108;14219.64450888736;13404.32978351098;13532.188068715908;13868.514601988882;13905.930470347583;14100.36548355306;10147;10412.531436085394;10426.843597346198;10444.895551044545;10487.790244195074;6725.8991115134295;6737.696803643946;7084.822879427849;7116.35952764233;7246.6376681166785;10204.591816327264;12185.817212741638;12741.362931853555;12762.106652534234;12772.169808962388;12772.552960646333;12800.35998200105;12888.355582221038;12898.226106433644;13030.609081727564;9528.761780955254;9659.372140811105;9705.854412183964;9743.902560974582;9760.560774765294;10416.739581510523;10614.0447359738;10653.307535010199;10653.520591573242;10679.733006674895;8327.50034997902;8729.738107856774;8846.778830529289;8961.641534338554;8962.193402593797;6895.965520172367;8785;8818.426802257833;8893.866592000995;9075.909240907506;8046.718364857202;8212.83574328498;8225.300849427866;8226.753197404087;8235.29999949987;5979.671118088547;5988.790392336247;6043.516518678583;6196.938030619816;6198.349173336735;6036.426539478743;6175.567710260419;6202.34875338101;6229.595076320206;6294.370562943669 09:01:30 INFO - PROCESS | 3274 | |4;prototype.html;327.973443123025;345.939460594396;382.6154714511915;393.4079210787764;397.79513550521466;4528.909421811566;4711.717296962184;4915.283005681082;5089.142463001006;5143.248362126264;4423.156643475398;4978.626603004771;5025.698458092517;5032.82385116521;5059.433099664737;3445.431503801876;3732.9066773330746;3767.566729826078;4209.85265515707;4259.70182087254;3610.855565777379;3762.529683789526;3790.9431358529505;3990.321645320288;4007.438958545806;3771.5097037385103;3790.5072340595684;4243.893902652428;4244.87265382039;4283.057727299989;3835.2137811748526;4086.244044851712;4154.987633965351;4240.936385954213;4449.332600109977;3842.5965273646425;3844.3464611016193;3848.2688289224957;3868.5763099656724;3873.1602488817866;4904.5831104356175;4954.380702412199;4955.975220123913;4956.6282528810125;4992.9251061233745;4223.429836972;4456.844010459651;4587.449506059261;4682.672212945095;4929.827456039022;4355.237833379146;4667.809708524304;5210.452902445227;5226.92159617606;5314.282571852789;3646.835892384849;3739.3082279778055;4421.977890110561;4422.292433210703;4422.513523512411;4335;5458.808941687022;5565.469495888622;5828.0966450200285;5923.985844812784;3419.333230020172;3784.905377365588;4140.875773726793;4391.389041506405;4475.686701930834;3615.421532554831;4004.7196696231567;4080.1227736036894;4271.658267338606;4564.954350456453;4202.2646036943415;4668.346431499593;4800.279958006257;4846.684965477303;4911.950880491149;4293.656507479394;5247.816326428557;5262.578993680497;5391.595630327741;5459.890802184013;1305.4973835073374;1355.9118657287443;1361.6800051987775;1514.2277438506221;1516.9848301516843;999.645125980281;1092.2736380307165;1148.8047032004579;1170.4674373160362;1180.2505409065304;5001.873828856965;5119.542619542566;5153.201253805666;5167.173252279617;5167.534921857051;4417.072414792865;4978.8755281118265;5434.755436005389;5519.902437073966;5533;4731.550502702238;4767.927903001071;5087.2528834428995;5172.267290457738;5203.375594928632;2662.201339598113;2815.3806162644187;2818.22498812824;2872.7989040766947;2873.6407949006375;5732.426757324234;5747;5773.971130144322;5775.5668324875805;5815.389384114692;4658.883527911829;5383.43473935239;5624.29696287964;5695.515881150149;5804.767809287581;5075.720835354091;5100.413452452867;5269.130593452038;5430.511253987082;5785.508231800344;4782.378290822171;5225.1378522543355;5288.963748956602;5627.7900251446135;5702.458266464845;4740.3837501124635;4930.334404855299;5264.684118952875;5323.574114070942;5392.379876314274;5207.869803254949;5405.729713514387;5422.267993820784;5759.308882934075;5772.7690892363835;3853.672437842815;3962.980185099056;4056.350983842689;4380.912381752283;4431.892026993251;4942.901141977212;5157.530103920365;5254.448282930391;5475.808346707846;5624.831255062355;4819.662623616313;4986.750662466935;5251.501107394792;5346.625736198429;5373.017975023899;4573.634109271316;5380.874554550852;5410.161424979135;5420.810271640474;5522.968233189714;4654.627629789541;4713.434387873477;4722.811087556596;4992.500749924979;5246.30455742101;5196.766145523537;5350.191149646466;5356.678599284055;5361.597880158925;5363.390982705251;4443.977780111208;4861.368022157097;4878.56092951636;5290.497402746733;5353.946460535501 09:01:30 INFO - PROCESS | 3274 | |5;yui.html;757.3713817531446;778.6145857800383;807.0517142357731;896.1533881148026;904.1546154345688;15630.843691563081;16463.670726585475;17173.82826171738;17700.203490842912;17722.822771772277;15756.76364854528;15914.204289785523;15966.28151733172;16156.03063816172;16455.2595133219;971.8785151856018;978.9021097890226;981.8723565936453;982.4841957972086;982.7150126463317;973.0707174648229;975.5317447625144;986.9753256168617;986.9883369546201;996.9850452243222;982.4722556424757;1024.6567399921034;1027.291169093327;1027.650598796409;1028.850816631588;895.4850960697624;995.0348162282575;1021.3310281765456;1021.5658345203296;1021.836506159011;761.6648674583221;762.3443838299058;762.3977058124075;762.6072572625103;764.6673696941848;16736.916315418344;16913.408030718867;16953.067581283147;17549.56126096845;17839.286428542844;14018.929905350407;14218.644533886632;14285.000049996504;14292.785608215885;14308.427662893471;10767.676969690921;11339.072357699211;12160.574379896661;12200.816987745191;12717.554885579053;3830.3296923038356;3883.2815929053218;3942.4283478895686;4021.577734337882;4032.697547683935;114803;120356.19465708021;121765;122104;123339;11286.774264514828;11446.313221206754;11509.827352589718;11692.240004399688;11916.46375913086;24251.15120970793;24320.391990200034;24580.877095614407;24598.385040374134;24639.26082217536;7122.679479423438;8133.877991830127;8163.79590510242;8242.670293188325;8245.670173193124;4632.86101416958;4634.351190833286;4686.74222917736;4727.669063165614;4922.941567562991;3522.753407261467;3624.3657359961903;3636.1818590816856;3644.781313121221;3651.397519409321;527.4093015822227;655.3446553446554;697.5849369625065;772.2702046566053;778.6956847280782;565.7623798004848;586.8151532267323;605.2162449627742;628.5129025005566;652.9183852018498;9103.772405689911;9740.415575065377;9972.401655900669;10545.630902918361;10987.340759554452;717.9832999464454;729.7227053719658;737.2295950731499;748.0163584885858;750.3996802557932;5128.8717782055;5196.685303514422;5253.973730131402;5302.260573048565;5310.495502927216;88112.55943720369;90642.54678726564;90798.54600727087;96135.51932240294;105202;63900.36099639037;83570;86045.569772152;87047.56476217705;89626.55186724024;69519.65240173767;70549;73600.63199683861;76310;81659.18340816516;10694.83957740619;11282.830757538808;11402.486888090221;11411.771764564828;11541.826872597087;50070;50732.49267507425;52405.47594524158;52651.73674131605;54348;63879.680601596694;65088;65176.67411662911;65396;65669;13251.536196233086;13429.932850335686;13487.123336983064;13491;14062.367193476523;14873.628159296104;14877;14982.625434364229;15664.373425063326;16094.597635059217;13656.53637275217;13767.311634418038;14476.855231447971;14684.045537040058;15024.849751502783;13731.271796560335;13944;14151.929240353733;14634.268286585415;14652.135293471843;13437;13965.162090274209;14113.717725645634;14133;14290.928545357207;9690.612375504901;10133.18934485254;10321.535530900977;10367.94816025915;10378.325408848703;11266.324020558794;11559.364234967157;11629.360385178896;11639.243449176116;11659.18385712992 09:01:30 INFO - PROCESS | 3274 | __end_tp_report 09:01:30 INFO - PROCESS | 3274 | __start_cc_report 09:01:30 INFO - PROCESS | 3274 | _x_x_mozilla_cycle_collect,2021 09:01:30 INFO - PROCESS | 3274 | __end_cc_report 09:01:30 INFO - PROCESS | 3274 | __startTimestamp1493827290097__endTimestamp 09:01:30 INFO - PROCESS | 3274 | 09:01:30 INFO - PROCESS | 3274 | ------- Summary: start ------- 09:01:30 INFO - PROCESS | 3274 | Number of tests: 6 09:01:30 INFO - PROCESS | 3274 | 09:01:30 INFO - PROCESS | 3274 | [#0] dojo.html Cycles:165 Average:5844.66 Median:6104.24 stddev:663.17 (10.9%) stddev-sans-first:612.94 09:01:30 INFO - PROCESS | 3274 | Values: 2554.9 3444.4 3470.5 3473.9 3497.2 5831.3 5876.2 5899.5 5903.9 5909.8 5900.4 5943.8 5951.3 5965.0 5974.9 5221.8 5227.3 5240.0 5259.1 5343.5 5171.5 5182.7 5206.6 5344.1 5347.9 5276.0 5298.5 5307.7 5314.0 5328.1 5302.6 5310.3 5331.2 5336.1 5346.4 5113.2 5210.9 5266.8 5278.5 5308.2 5760.4 5769.5 5779.5 5783.5 5797.7 6201.9 6209.4 6251.2 6265.3 6287.7 6279.5 6309.2 6312.8 6321.2 6343.3 6007.5 6013.8 6014.2 6017.8 6070.0 6224.7 6345.2 6390.0 6417.8 6428.5 6188.9 6256.5 6260.2 6289.7 6311.5 6329.5 6344.2 6347.4 6357.3 6372.4 6282.0 6285.3 6297.4 6313.7 6325.1 6160.5 6202.4 6235.9 6267.9 6272.2 5061.7 5062.2 5062.7 5089.7 5096.5 4518.8 4532.4 4549.2 4573.8 4585.2 5787.5 5898.0 5928.6 6097.0 6143.9 6243.4 6257.9 6264.9 6309.7 6334.7 6026.1 6030.5 6063.5 6078.8 6097.4 5466.9 5527.0 5537.3 5552.5 5552.7 6263.9 6313.0 6350.2 6359.3 6360.1 6261.2 6265.5 6295.6 6297.6 6315.9 6471.6 6508.4 6515.9 6524.2 6547.0 6305.1 6309.9 6315.5 6320.2 6350.1 6206.2 6239.8 6270.6 6305.4 6306.0 5074.5 6243.3 6258.4 6282.2 6284.9 5742.3 6206.4 6255.8 6289.4 6294.2 5280.6 5900.6 5911.9 6155.8 6174.8 6075.9 6161.0 6201.5 6275.7 6294.0 5984.0 5986.5 6104.2 6107.6 6143.0 09:01:30 INFO - PROCESS | 3274 | 09:01:30 INFO - PROCESS | 3274 | [#1] ext.html Cycles:180 Average:56876.27 Median:315850.50 stddev:116921.74 (37.0%) stddev-sans-first:117173.79 09:01:30 INFO - PROCESS | 3274 | Values: 746.5 811.9 828.8 901.3 907.5 30010.1 30426.0 40963.0 41408.8 43505.6 41934.6 42360.4 42431.5 42476.4 42503.6 9510.1 9675.5 9694.0 9696.5 9726.2 7915.4 8031.8 9549.8 11671.9 11775.8 11735.3 11830.5 11832.6 11860.1 11867.4 11764.4 11784.3 11787.9 11788.3 11816.6 9974.2 11181.6 11418.8 11464.7 11483.0 34845.8 37117.0 39515.0 39718.0 39819.0 3941.7 3989.8 3998.2 4003.3 4083.1 28045.7 30041.9 30623.8 30701.5 30742.1 3070.5 3254.2 3261.9 3278.1 3422.5 313996.0 315717.0 315984.0 316100.4 316622.4 50941.0 50944.7 51015.7 51071.0 51101.7 53762.7 53778.7 53841.7 53859.0 53898.7 15082.1 15450.0 15455.2 15467.7 15478.9 13220.9 13229.7 13235.2 13263.6 13277.0 10547.2 10740.4 10815.7 12016.0 12143.5 4912.3 5474.6 5493.5 5588.4 5631.9 1087.2 1118.7 1125.3 1149.0 1190.9 27837.9 28053.6 28265.7 28341.0 28359.6 1191.7 1199.5 1236.2 1241.0 1244.7 14244.6 14389.3 14443.9 14760.1 14798.6 461245.0 469631.0 469691.0 470134.9 470775.0 45647.3 46382.5 57031.7 57423.0 57432.4 1420.6 1526.8 1533.3 1540.1 1545.4 29279.9 30272.4 30776.2 30818.4 31061.2 37286.6 38574.2 47330.5 47404.3 47438.6 478974.0 481761.0 482183.0 492308.0 605896.0 34268.5 34544.0 34634.0 34801.8 34835.0 35707.0 42739.8 43865.3 44362.6 45075.8 27979.2 28321.6 29377.4 29443.7 30089.2 29089.9 29181.4 29212.1 29254.4 29347.0 33368.0 33879.0 34124.8 34173.7 34297.8 28664.0 28818.7 29155.9 29618.3 29774.0 22050.9 23283.3 23620.3 23727.9 23755.6 09:01:30 INFO - PROCESS | 3274 | 09:01:30 INFO - PROCESS | 3274 | [#2] jquery.html Cycles:180 Average:43910.84 Median:23033.21 stddev:127436.17 (553.3%) stddev-sans-first:127751.75 09:01:30 INFO - PROCESS | 3274 | Values: 382.7 423.7 427.3 437.4 463.1 18165.4 20373.7 21077.0 22374.2 22535.9 22710.5 23596.8 24024.8 24257.4 24391.9 6899.5 7046.1 7115.0 7166.5 7173.0 6793.7 6888.1 7036.1 7042.3 7055.3 7035.6 7065.8 7518.2 7793.7 7886.0 7640.2 7817.8 7861.6 7966.2 7996.4 7577.0 7622.6 7681.1 7694.1 7705.7 27696.4 27918.3 28191.4 28492.0 28593.3 3028.1 3103.6 3116.1 3139.6 3149.3 16368.6 16479.4 16898.0 17105.7 17460.0 2110.4 2117.6 2145.3 2147.3 2261.3 98264.0 118817.6 170942.0 172946.0 173767.1 18278.4 19027.0 20001.7 20803.4 20905.7 33145.3 33344.7 33710.3 33734.3 33754.0 10819.1 11075.2 11108.7 11158.2 11351.3 9195.8 9218.5 9229.6 9455.4 9459.8 9418.7 9685.6 9755.9 9762.5 9772.9 2475.9 3807.3 3863.9 3876.6 3879.4 996.0 1011.3 1057.9 1097.5 1105.2 22476.7 22662.9 23012.8 23053.7 23071.5 906.8 945.4 987.8 1024.2 1048.6 8781.7 11537.5 11665.7 11684.6 11807.3 632188.0 736273.0 796130.0 819215.0 819502.0 155753.0 156233.0 162277.2 164797.0 168674.4 1214.0 1307.4 1319.6 1369.6 1379.2 20671.9 20836.9 21293.7 21337.5 21420.0 56170.4 63932.7 64473.7 64788.7 65217.0 88900.7 89204.6 89644.6 92127.0 92950.1 9802.2 11141.6 11724.0 11765.4 12074.7 10497.5 13095.5 13499.0 13511.8 13548.9 10602.7 10726.7 11195.7 11859.2 11896.6 10511.3 10592.5 10636.5 10902.6 11003.1 11104.3 11631.4 11801.9 11871.3 11913.8 11605.2 11623.5 11689.2 11776.5 12039.9 9269.6 10971.7 11021.4 11062.6 11392.2 09:01:30 INFO - PROCESS | 3274 | 09:01:30 INFO - PROCESS | 3274 | [#3] mootools.html Cycles:180 Average:6882.31 Median:2472.12 stddev:4284.07 (173.3%) stddev-sans-first:4277.07 09:01:30 INFO - PROCESS | 3274 | Values: 1509.3 1594.9 1605.2 1617.0 1622.8 10956.0 11645.9 11646.1 11652.5 11674.8 11099.6 11368.1 11388.2 11647.5 11675.4 2041.8 2436.8 2467.7 2476.9 2481.9 2394.2 2453.1 2474.9 2485.2 2488.8 2392.3 2454.0 2469.4 2479.7 2481.0 2362.4 2428.0 2435.0 2440.8 2464.8 2422.0 2442.2 2452.7 2455.5 2462.1 9321.8 11501.3 11513.3 11513.7 11514.2 5883.9 6076.4 6083.5 6089.7 6110.0 3583.2 3652.1 3675.0 3721.2 3721.9 1224.9 1237.5 1283.9 1291.4 1313.2 14039.9 14296.6 14746.9 15744.6 15935.6 4655.8 4817.3 4850.8 4856.1 4870.0 10511.7 12167.9 12172.1 12174.0 12191.0 5135.8 5817.8 5891.1 5988.0 6030.4 5241.4 5384.4 5420.7 5467.1 5490.3 3324.4 3540.6 3804.1 3949.2 3978.2 1034.1 1036.7 1039.4 1039.8 1060.0 799.2 840.2 843.0 862.2 884.4 6801.7 6845.2 6902.4 6982.6 7061.5 989.1 1038.5 1041.8 1048.3 1058.9 4246.6 4365.5 4509.7 4514.5 4528.5 13587.8 14173.3 14198.0 14206.9 14219.6 13404.3 13532.2 13868.5 13905.9 14100.4 10147.0 10412.5 10426.8 10444.9 10487.8 6725.9 6737.7 7084.8 7116.4 7246.6 10204.6 12185.8 12741.4 12762.1 12772.2 12772.6 12800.4 12888.4 12898.2 13030.6 9528.8 9659.4 9705.9 9743.9 9760.6 10416.7 10614.0 10653.3 10653.5 10679.7 8327.5 8729.7 8846.8 8961.6 8962.2 6896.0 8785.0 8818.4 8893.9 9075.9 8046.7 8212.8 8225.3 8226.8 8235.3 5979.7 5988.8 6043.5 6196.9 6198.3 6036.4 6175.6 6202.3 6229.6 6294.4 09:01:30 INFO - PROCESS | 3274 | 09:01:30 INFO - PROCESS | 3274 | [#4] prototype.html Cycles:180 Average:4446.69 Median:4854.03 stddev:1257.86 (25.9%) stddev-sans-first:1222.81 09:01:30 INFO - PROCESS | 3274 | Values: 328.0 345.9 382.6 393.4 397.8 4528.9 4711.7 4915.3 5089.1 5143.2 4423.2 4978.6 5025.7 5032.8 5059.4 3445.4 3732.9 3767.6 4209.9 4259.7 3610.9 3762.5 3790.9 3990.3 4007.4 3771.5 3790.5 4243.9 4244.9 4283.1 3835.2 4086.2 4155.0 4240.9 4449.3 3842.6 3844.3 3848.3 3868.6 3873.2 4904.6 4954.4 4956.0 4956.6 4992.9 4223.4 4456.8 4587.4 4682.7 4929.8 4355.2 4667.8 5210.5 5226.9 5314.3 3646.8 3739.3 4422.0 4422.3 4422.5 4335.0 5458.8 5565.5 5828.1 5924.0 3419.3 3784.9 4140.9 4391.4 4475.7 3615.4 4004.7 4080.1 4271.7 4565.0 4202.3 4668.3 4800.3 4846.7 4912.0 4293.7 5247.8 5262.6 5391.6 5459.9 1305.5 1355.9 1361.7 1514.2 1517.0 999.6 1092.3 1148.8 1170.5 1180.3 5001.9 5119.5 5153.2 5167.2 5167.5 4417.1 4978.9 5434.8 5519.9 5533.0 4731.6 4767.9 5087.3 5172.3 5203.4 2662.2 2815.4 2818.2 2872.8 2873.6 5732.4 5747.0 5774.0 5775.6 5815.4 4658.9 5383.4 5624.3 5695.5 5804.8 5075.7 5100.4 5269.1 5430.5 5785.5 4782.4 5225.1 5289.0 5627.8 5702.5 4740.4 4930.3 5264.7 5323.6 5392.4 5207.9 5405.7 5422.3 5759.3 5772.8 3853.7 3963.0 4056.4 4380.9 4431.9 4942.9 5157.5 5254.4 5475.8 5624.8 4819.7 4986.8 5251.5 5346.6 5373.0 4573.6 5380.9 5410.2 5420.8 5523.0 4654.6 4713.4 4722.8 4992.5 5246.3 5196.8 5350.2 5356.7 5361.6 5363.4 4444.0 4861.4 4878.6 5290.5 5353.9 09:01:30 INFO - PROCESS | 3274 | 09:01:30 INFO - PROCESS | 3274 | [#5] yui.html Cycles:180 Average:20775.90 Median:3630.27 stddev:29305.47 (807.3%) stddev-sans-first:29349.13 09:01:30 INFO - PROCESS | 3274 | Values: 757.4 778.6 807.1 896.2 904.2 15630.8 16463.7 17173.8 17700.2 17722.8 15756.8 15914.2 15966.3 16156.0 16455.3 971.9 978.9 981.9 982.5 982.7 973.1 975.5 987.0 987.0 997.0 982.5 1024.7 1027.3 1027.7 1028.9 895.5 995.0 1021.3 1021.6 1021.8 761.7 762.3 762.4 762.6 764.7 16736.9 16913.4 16953.1 17549.6 17839.3 14018.9 14218.6 14285.0 14292.8 14308.4 10767.7 11339.1 12160.6 12200.8 12717.6 3830.3 3883.3 3942.4 4021.6 4032.7 114803.0 120356.2 121765.0 122104.0 123339.0 11286.8 11446.3 11509.8 11692.2 11916.5 24251.2 24320.4 24580.9 24598.4 24639.3 7122.7 8133.9 8163.8 8242.7 8245.7 4632.9 4634.4 4686.7 4727.7 4922.9 3522.8 3624.4 3636.2 3644.8 3651.4 527.4 655.3 697.6 772.3 778.7 565.8 586.8 605.2 628.5 652.9 9103.8 9740.4 9972.4 10545.6 10987.3 718.0 729.7 737.2 748.0 750.4 5128.9 5196.7 5254.0 5302.3 5310.5 88112.6 90642.5 90798.5 96135.5 105202.0 63900.4 83570.0 86045.6 87047.6 89626.6 69519.7 70549.0 73600.6 76310.0 81659.2 10694.8 11282.8 11402.5 11411.8 11541.8 50070.0 50732.5 52405.5 52651.7 54348.0 63879.7 65088.0 65176.7 65396.0 65669.0 13251.5 13429.9 13487.1 13491.0 14062.4 14873.6 14877.0 14982.6 15664.4 16094.6 13656.5 13767.3 14476.9 14684.0 15024.8 13731.3 13944.0 14151.9 14634.3 14652.1 13437.0 13965.2 14113.7 14133.0 14290.9 9690.6 10133.2 10321.5 10367.9 10378.3 11266.3 11559.4 11629.4 11639.2 11659.2 09:01:30 INFO - PROCESS | 3274 | -------- Summary: end -------- 09:01:30 INFO - PROCESS | 3274 | 09:01:30 INFO - TEST-INFO | 3274: exit 0 09:01:30 INFO - TEST-OK | dromaeo_css | took 1118571ms 09:01:30 INFO - TEST-START | kraken 09:01:30 INFO - operating with platform_type : mac_ 09:01:30 INFO - Initialising browser for kraken test... 09:01:30 INFO - TEST-INFO | started process 3277 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp4EdBmT/profile http://localhost:65143/getInfo.html) 09:01:33 INFO - PROCESS | 3277 | __metrics Screen width/height:1600/1200 09:01:33 INFO - PROCESS | 3277 | colorDepth:24 09:01:33 INFO - PROCESS | 3277 | Browser inner width/height: 1024/689 09:01:33 INFO - PROCESS | 3277 | __metrics 09:01:33 INFO - PROCESS | 3277 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:01:33 INFO - PROCESS | 3277 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:01:34 INFO - TEST-INFO | 3277: exit 0 09:01:34 INFO - Browser initialized. 09:01:34 INFO - Running cycle 1/1 for kraken test... 09:01:34 INFO - TEST-INFO | started process 3279 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/tmp4EdBmT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:01:46 INFO - PROCESS | 3279 | RSS: Main: 165498880 09:01:46 INFO - PROCESS | 3279 | 09:01:48 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:65143/tests/kraken/driver.html?testName=audio-beat-detection) 09:01:49 INFO - PROCESS | 3279 | RSS: Main: 216346624 09:01:49 INFO - PROCESS | 3279 | 09:01:52 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:65143/tests/kraken/driver.html?testName=audio-dft) 09:01:52 INFO - PROCESS | 3279 | RSS: Main: 231481344 09:01:52 INFO - PROCESS | 3279 | 09:01:55 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:65143/tests/kraken/driver.html?testName=audio-fft) 09:01:56 INFO - PROCESS | 3279 | RSS: Main: 329244672 09:01:56 INFO - PROCESS | 3279 | 09:01:58 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:65143/tests/kraken/driver.html?testName=audio-oscillator) 09:01:59 INFO - PROCESS | 3279 | RSS: Main: 229797888 09:01:59 INFO - PROCESS | 3279 | 09:02:01 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:65143/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:01 INFO - PROCESS | 3279 | RSS: Main: 232443904 09:02:01 INFO - PROCESS | 3279 | 09:02:04 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:65143/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:05 INFO - PROCESS | 3279 | RSS: Main: 271728640 09:02:05 INFO - PROCESS | 3279 | 09:02:08 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:65143/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:09 INFO - PROCESS | 3279 | RSS: Main: 275668992 09:02:09 INFO - PROCESS | 3279 | 09:02:11 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:65143/tests/kraken/driver.html?testName=json-parse-financial) 09:02:12 INFO - PROCESS | 3279 | RSS: Main: 272470016 09:02:12 INFO - PROCESS | 3279 | 09:02:14 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:65143/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:14 INFO - PROCESS | 3279 | RSS: Main: 249131008 09:02:14 INFO - PROCESS | 3279 | 09:02:16 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:65143/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:17 INFO - PROCESS | 3279 | RSS: Main: 251822080 09:02:17 INFO - PROCESS | 3279 | 09:02:19 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:65143/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:20 INFO - PROCESS | 3279 | RSS: Main: 255647744 09:02:20 INFO - PROCESS | 3279 | 09:02:22 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:65143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:23 INFO - PROCESS | 3279 | RSS: Main: 273752064 09:02:23 INFO - PROCESS | 3279 | 09:02:26 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:65143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:27 INFO - PROCESS | 3279 | RSS: Main: 266842112 09:02:27 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | Cycle 1(1): loaded http://localhost:65143/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:65143/tests/kraken/driver.html?testName=ai-astar) 09:02:29 INFO - PROCESS | 3279 | RSS: Main: 311312384 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | __start_tp_report 09:02:29 INFO - PROCESS | 3279 | _x_x_mozilla_page_load 09:02:29 INFO - PROCESS | 3279 | _x_x_mozilla_page_load_details 09:02:29 INFO - PROCESS | 3279 | |i|pagename|runs| 09:02:29 INFO - PROCESS | 3279 | |0;ai-astar;103;116;115;115;116;116;115;115;115;117 09:02:29 INFO - PROCESS | 3279 | |1;audio-beat-detection;128;105;106;138;108;105;107;104;123;107 09:02:29 INFO - PROCESS | 3279 | |2;audio-dft;184;184;186;183;187;186;184;195;262;206 09:02:29 INFO - PROCESS | 3279 | |3;audio-fft;82;58;60;80;60;65;81;84;100;61 09:02:29 INFO - PROCESS | 3279 | |4;audio-oscillator;85;69;87;69;73;93;114;99;67;83 09:02:29 INFO - PROCESS | 3279 | |5;imaging-gaussian-blur;87;88;89;88;88;89;87;90;89;88 09:02:29 INFO - PROCESS | 3279 | |6;imaging-darkroom;95;94;95;94;93;94;94;95;105;151 09:02:29 INFO - PROCESS | 3279 | |7;imaging-desaturate;87;81;87;85;87;86;85;83;87;83 09:02:29 INFO - PROCESS | 3279 | |8;json-parse-financial;63;59;59;60;62;63;63;62;63;64 09:02:29 INFO - PROCESS | 3279 | |9;json-stringify-tinderbox;55;58;71;65;61;58;59;57;59;58 09:02:29 INFO - PROCESS | 3279 | |10;stanford-crypto-aes;84;80;89;99;98;99;84;83;80;89 09:02:29 INFO - PROCESS | 3279 | |11;stanford-crypto-ccm;134;134;132;134;141;134;154;147;181;129 09:02:29 INFO - PROCESS | 3279 | |12;stanford-crypto-pbkdf2;167;161;184;163;162;161;159;162;160;159 09:02:29 INFO - PROCESS | 3279 | |13;stanford-crypto-sha256-iterative;64;64;64;64;63;64;63;62;63;62 09:02:29 INFO - PROCESS | 3279 | __end_tp_report 09:02:29 INFO - PROCESS | 3279 | __start_cc_report 09:02:29 INFO - PROCESS | 3279 | _x_x_mozilla_cycle_collect,2179 09:02:29 INFO - PROCESS | 3279 | __end_cc_report 09:02:29 INFO - PROCESS | 3279 | __startTimestamp1493827349274__endTimestamp 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | ------- Summary: start ------- 09:02:29 INFO - PROCESS | 3279 | Number of tests: 14 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#0] ai-astar Cycles:10 Average:114.30 Median:115.50 stddev:4.03 (3.5%) stddev-sans-first:0.73 09:02:29 INFO - PROCESS | 3279 | Values: 103.0 116.0 115.0 115.0 116.0 116.0 115.0 115.0 115.0 117.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#1] audio-beat-detection Cycles:10 Average:113.10 Median:107.50 stddev:12.04 (11.2%) stddev-sans-first:11.50 09:02:29 INFO - PROCESS | 3279 | Values: 128.0 105.0 106.0 138.0 108.0 105.0 107.0 104.0 123.0 107.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#2] audio-dft Cycles:10 Average:195.70 Median:186.50 stddev:24.35 (13.1%) stddev-sans-first:25.46 09:02:29 INFO - PROCESS | 3279 | Values: 184.0 184.0 186.0 183.0 187.0 186.0 184.0 195.0 262.0 206.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#3] audio-fft Cycles:10 Average:73.10 Median:72.50 stddev:14.20 (19.6%) stddev-sans-first:14.69 09:02:29 INFO - PROCESS | 3279 | Values: 82.0 58.0 60.0 80.0 60.0 65.0 81.0 84.0 100.0 61.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:84.00 stddev:15.19 (18.1%) stddev-sans-first:16.11 09:02:29 INFO - PROCESS | 3279 | Values: 85.0 69.0 87.0 69.0 73.0 93.0 114.0 99.0 67.0 83.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:88.50 stddev:0.95 (1.1%) stddev-sans-first:0.88 09:02:29 INFO - PROCESS | 3279 | Values: 87.0 88.0 89.0 88.0 88.0 89.0 87.0 90.0 89.0 88.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#6] imaging-darkroom Cycles:10 Average:101.00 Median:94.00 stddev:17.90 (19.0%) stddev-sans-first:18.85 09:02:29 INFO - PROCESS | 3279 | Values: 95.0 94.0 95.0 94.0 93.0 94.0 94.0 95.0 105.0 151.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:86.50 stddev:2.13 (2.5%) stddev-sans-first:2.15 09:02:29 INFO - PROCESS | 3279 | Values: 87.0 81.0 87.0 85.0 87.0 86.0 85.0 83.0 87.0 83.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#8] json-parse-financial Cycles:10 Average:61.80 Median:63.00 stddev:1.81 (2.9%) stddev-sans-first:1.87 09:02:29 INFO - PROCESS | 3279 | Values: 63.0 59.0 59.0 60.0 62.0 63.0 63.0 62.0 63.0 64.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#9] json-stringify-tinderbox Cycles:10 Average:60.10 Median:59.00 stddev:4.65 (7.9%) stddev-sans-first:4.56 09:02:29 INFO - PROCESS | 3279 | Values: 55.0 58.0 71.0 65.0 61.0 58.0 59.0 57.0 59.0 58.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.00 stddev:7.65 (8.6%) stddev-sans-first:7.94 09:02:29 INFO - PROCESS | 3279 | Values: 84.0 80.0 89.0 99.0 98.0 99.0 84.0 83.0 80.0 89.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:137.50 stddev:15.69 (11.4%) stddev-sans-first:16.37 09:02:29 INFO - PROCESS | 3279 | Values: 134.0 134.0 132.0 134.0 141.0 134.0 154.0 147.0 181.0 129.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:162.00 stddev:7.47 (4.6%) stddev-sans-first:7.83 09:02:29 INFO - PROCESS | 3279 | Values: 167.0 161.0 184.0 163.0 162.0 161.0 159.0 162.0 160.0 159.0 09:02:29 INFO - PROCESS | 3279 | 09:02:29 INFO - PROCESS | 3279 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.30 Median:64.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 09:02:29 INFO - PROCESS | 3279 | Values: 64.0 64.0 64.0 64.0 63.0 64.0 63.0 62.0 63.0 62.0 09:02:29 INFO - PROCESS | 3279 | -------- Summary: end -------- 09:02:29 INFO - PROCESS | 3279 | 09:02:30 INFO - TEST-INFO | 3279: exit 0 09:02:30 INFO - TEST-OK | kraken | took 59329ms 09:02:30 INFO - SUITE-END | took 1177s 09:02:30 INFO - Completed test suite (00:19:38) 09:02:30 INFO - javascript benchmark 09:02:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7798.374367117057, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2554.87225638718, 3444.431668774653, 3470.4794280857855, 3473.930521389571, 3497.1956450016496, 5831.329397119327, 5876.236089308384, 5899.469047785698, 5903.911441328372, 5909.822705318842, 5900.380460051697, 5943.821685349447, 5951.345352011275, 5965.0, 5974.910376344347, 5221.765020574065, 5227.32044834171, 5240.0, 5259.105951988152, 5343.465653434664, 5171.50870667286, 5182.714950677711, 5206.609504287175, 5344.118220493614, 5347.893042139155, 5275.973620131894, 5298.549623282026, 5307.734613269321, 5314.043472175007, 5328.120860058086, 5302.6023048271345, 5310.256564081032, 5331.2003199519995, 5336.146216605344, 5346.438623944468, 5113.2330150477355, 5210.921836172461, 5266.8419947401635, 5278.524932756032, 5308.203769434577, 5760.423957604248, 5769.480746732815, 5779.537636989031, 5783.450572195635, 5797.652140871562, 6201.906971395432, 6209.3790620938, 6251.187345645082, 6265.279492858334, 6287.748490060392, 6279.466245369149, 6309.211348581427, 6312.779052733133, 6321.24145102586, 6343.27052388972, 6007.459328660398, 6013.849653758691, 6014.1580178775, 6017.7592896284095, 6070.0, 6224.688765561704, 6345.206849143857, 6390.0, 6417.7753778617525, 6428.5178611604315, 6188.938110618927, 6256.468200202943, 6260.186175797208, 6289.654069026247, 6311.526635502356, 6329.493640508748, 6344.206974128234, 6347.39699728525, 6357.332480089616, 6372.36276372359, 6282.0, 6285.277193122758, 6297.4017468340435, 6313.715882785285, 6325.146105275729, 6160.476359509492, 6202.4107709768405, 6235.906461403082, 6267.9373206268265, 6272.18461599989, 5061.746912654353, 5062.190049592047, 5062.670926389773, 5089.694618322838, 5096.541311282002, 4518.819247230074, 4532.410786597788, 4549.226631472658, 4573.839915602938, 4585.220512512881, 5787.479126878601, 5898.026825573732, 5928.644281343133, 6096.9893995752245, 6143.907841382383, 6243.43809057178, 6257.936150854366, 6264.874702506016, 6309.747610095636, 6334.651594162273, 6026.0659597762415, 6030.517558595389, 6063.454289114001, 6078.817635470943, 6097.359777223416, 5466.890662186734, 5526.972365138148, 5537.335519737658, 5552.472515111058, 5552.7223638817895, 6263.937360626335, 6312.958361870332, 6350.206224221973, 6359.300476947625, 6360.109584658244, 6261.186045814015, 6265.49876009909, 6295.559310848196, 6297.559170857996, 6315.873682526232, 6471.611703297817, 6508.381703738138, 6515.934840651533, 6524.151860258136, 6546.967265163644, 6305.085762564494, 6309.905351419824, 6315.4947604192475, 6320.209973753281, 6350.110984462087, 6206.193194884636, 6239.812805615838, 6270.561060725888, 6305.369463053658, 6305.96847015762, 5074.517920797518, 6243.313235543996, 6258.405451482102, 6282.2147231596055, 6284.937150628618, 5742.310922689304, 6206.441420272197, 6255.843603909757, 6289.433950944437, 6294.15028971083, 5280.551153152025, 5900.645961242168, 5911.940880591139, 6155.815325540241, 6174.783882564088, 6075.939240607538, 6161.045038019114, 6201.503879689524, 6275.6862156892885, 6294.0, 5983.970080149571, 5986.491148252448, 6104.236970378703, 6107.5760588585135, 6142.955697531341], "value": 5800.66950868204, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.5259560179288, 811.9188081191879, 828.755517122449, 901.2654686430559, 907.5008745190144, 30010.099697009096, 30426.0, 40962.97592560187, 41408.79295603518, 43505.564944350546, 41934.58065419345, 42360.36459453111, 42431.51489697861, 42476.36285455721, 42503.57496425035, 9510.144087032166, 9675.516224188797, 9694.0, 9696.515174241295, 9726.17327527161, 7915.366770658334, 8031.799205019863, 9549.809003819919, 11671.883281167164, 11775.823362649568, 11735.295882247092, 11830.526778928832, 11832.585859494919, 11860.110491713112, 11867.406629668525, 11764.352960587164, 11784.292942423397, 11787.88212117885, 11788.292702437795, 11816.58641947532, 9974.202063834948, 11181.608643697431, 11418.828717569244, 11464.713382165513, 11483.0, 34845.82577087123, 37117.0, 39515.0, 39718.0, 39819.0, 3941.6649584785328, 3989.780562069085, 3998.2203470323007, 4003.319435695939, 4083.060895993908, 28045.719542804516, 30041.94853180128, 30623.846880765454, 30701.539476907863, 30742.077737667907, 3070.508718605035, 3254.1864533866533, 3261.869525218988, 3278.1312952067483, 3422.469517224834, 313996.0, 315717.0, 315984.0, 316100.4194979033, 316622.41688791406, 50940.981180376184, 50944.74527627338, 51015.74492127515, 51071.0, 51101.744491277306, 53762.7311863446, 53778.73110634422, 53841.73079134579, 53859.0, 53898.730506347216, 15082.095074295357, 15450.0, 15455.227238638023, 15467.690646187239, 15478.9226053869, 13220.867791322156, 13229.73540529184, 13235.205887646773, 13263.602091937257, 13277.0, 10547.156227501782, 10740.355578665305, 10815.729606759895, 12016.0, 12143.514259429523, 4912.287718280901, 5474.631342164459, 5493.533049690821, 5588.413216612197, 5631.8592035199445, 1087.2389327470644, 1118.681175864891, 1125.2573301620891, 1148.9885101149048, 1190.9166358355005, 27837.860810696224, 28053.62958818704, 28265.71734282672, 28341.0, 28359.57460638092, 1191.7199458127334, 1199.4902166579168, 1236.190295356543, 1241.025794751134, 1244.6888277930518, 14244.572662819925, 14389.28053597316, 14443.916706247073, 14760.114393136446, 14798.630034249014, 461245.0, 469631.0, 469691.0, 470134.94797578064, 470775.0, 45647.31529027067, 46382.53617463782, 57031.71484142636, 57423.0, 57432.42567574354, 1420.566727148209, 1526.8472303411077, 1533.3406635146994, 1540.1144342003392, 1545.3895711194016, 29279.85360073186, 30272.394552108395, 30776.23059423443, 30818.44495458557, 31061.223469413446, 37286.62713372832, 38574.2285154301, 47330.52669473261, 47404.288935666686, 47438.576842694776, 478974.0, 481761.0, 482183.0, 492308.0, 605896.0, 34268.48597271093, 34544.0, 34634.0, 34801.82599086988, 34835.03902168344, 35707.0, 42739.78630106829, 43865.34201987037, 44362.556374435844, 45075.774621126686, 27979.160625181277, 28321.575176372782, 29377.412451751272, 29443.705562944095, 30089.247768805955, 29089.854550727112, 29181.416371672873, 29212.123636290944, 29254.41491170122, 29347.0, 33368.0, 33879.0, 34124.82937585296, 34173.658263418045, 34297.82851085729, 28664.0, 28818.711812881604, 29155.85422072876, 29618.259543511584, 29774.0, 22050.8974551275, 23283.301500955, 23620.291391258288, 23727.881360593776, 23755.643665344687], "value": 19092.224305846503, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.707228969838, 423.6907057847773, 427.2992292640069, 437.42260216514194, 463.147808033219, 18165.364212252574, 20373.694394584076, 21077.0, 22374.216902408418, 22535.887320563415, 22710.545789084208, 23596.764032359715, 24024.75975240247, 24257.39356516088, 24391.878040609816, 6899.517033807623, 7046.1192350956135, 7115.039469671606, 7166.498345115844, 7172.964135179317, 6793.6603169841555, 6888.10454640896, 7036.050133231999, 7042.2605626409, 7055.259197784236, 7035.613041282727, 7065.7880263591915, 7518.248175182493, 7793.688252469923, 7885.96057019717, 7640.197779233156, 7817.843643127134, 7861.56761378124, 7966.243206895336, 7996.360291176721, 7576.9621151894435, 7622.618869056525, 7681.116671582728, 7694.076710794685, 7705.730299439549, 27696.446071078666, 27918.302042448897, 28191.436171276666, 28492.002779902603, 28593.285167870763, 3028.1067085209916, 3103.587867520273, 3116.06518044588, 3139.623245210589, 3149.3228955774616, 16368.590785230346, 16479.423220187356, 16898.0, 17105.657886842317, 17460.039697816614, 2110.4407332057017, 2117.6188286108495, 2145.324222869791, 2147.3235930681785, 2261.31030035839, 98264.0, 118817.62364752656, 170942.0, 172946.0, 173767.13116434464, 18278.360257391192, 19027.048647567568, 20001.699974500105, 20803.37589872306, 20905.686414703487, 33145.337093258, 33344.66655333416, 33710.32579348399, 33734.325313493595, 33753.987380378625, 10819.080378167786, 11075.224734268684, 11108.666739997812, 11158.218924675357, 11351.318920864775, 9195.816083678288, 9218.492982885871, 9229.584668689926, 9455.385399948982, 9459.76350591227, 9418.656165395028, 9685.610036487315, 9755.926848046709, 9762.46306453152, 9772.9022709772, 2475.876206189683, 3807.276617442677, 3863.8840834775, 3876.5541962674088, 3879.3599056155417, 995.9850602240972, 1011.327467234281, 1057.9209206609216, 1097.4786976186408, 1105.247436025089, 22476.662850057262, 22662.886685566467, 23012.769872301396, 23053.654195187086, 23071.53856922852, 906.8005038891433, 945.3713280668278, 987.7629368951543, 1024.1806554756165, 1048.564845589072, 8781.652654096913, 11537.538498459968, 11665.650030499099, 11684.649460516028, 11807.291562506278, 632188.0, 736273.0, 796130.0, 819215.0, 819502.0, 155753.0, 156233.0, 162277.18861405618, 164797.0, 168674.40965156598, 1213.9635810925686, 1307.4443361571293, 1319.5843309357713, 1369.5891232629972, 1379.2276325257887, 20671.8966405167, 20836.895815520824, 21293.6805947914, 21337.466563336042, 21420.0, 56170.43829561652, 63932.680336598016, 64473.67763161154, 64788.67605661941, 65217.0, 88900.66649000141, 89204.5539772297, 89644.55177724331, 92127.0, 92950.07049929685, 9802.215822734022, 11141.554337826721, 11724.0, 11765.411729413667, 12074.698132546406, 10497.47512624381, 13095.476180953036, 13499.0, 13511.797323040359, 13548.864511355154, 10602.727672679328, 10726.65560042601, 11195.720106997065, 11859.16985810985, 11896.583619573274, 10511.316764410289, 10592.523336449724, 10636.52135653913, 10902.563897444013, 11003.064739497233, 11104.333739975627, 11631.418429078343, 11801.940990294994, 11871.287722736663, 11913.761724765629, 11605.187636865337, 11623.476943537393, 11689.181757276909, 11776.470058847544, 12039.939800301292, 9269.582868770787, 10971.725706857393, 11021.393823339793, 11062.557497700001, 11392.202545821712], "value": 11992.545053335767, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1509.275547737086, 1594.9282282297295, 1605.1893793634213, 1617.0459428936924, 1622.789037425135, 10955.99999999999, 11645.941770291158, 11646.126540509464, 11652.533898644066, 11674.766504669902, 11099.5560177593, 11368.09055275578, 11388.202825802196, 11647.534098636044, 11675.416229188528, 2041.7754047054812, 2436.7806897379187, 2467.6668649732237, 2476.938076548083, 2481.888315025828, 2394.221877889684, 2453.0678342229926, 2474.8638824864624, 2485.2047344849657, 2488.8133389995824, 2392.342105920868, 2454.0, 2469.370310570802, 2479.665245191903, 2481.0323973650293, 2362.4330160761465, 2427.9757202428013, 2435.0016493237863, 2440.8169387295848, 2464.7658472445087, 2421.9636705449434, 2442.157455677806, 2452.7424620414777, 2455.472073504205, 2462.064415522108, 9321.766955826091, 11501.252418592765, 11513.251638643462, 11513.654590362303, 11514.194006419553, 5883.911741323884, 6076.359382966619, 6083.513318934474, 6089.665068421235, 6109.969450152766, 3583.2475180212186, 3652.1052342176336, 3675.026118078711, 3721.1813401051727, 3721.9069523261865, 1224.9265044097383, 1237.5359240284893, 1283.9165454245444, 1291.4446787881207, 1313.1858247886275, 14039.929800350932, 14296.57110286693, 14746.852531474655, 15744.606384840356, 15935.601609959727, 4655.813767449264, 4817.325574419584, 4850.7873031742065, 4856.101621200019, 4870.0, 10511.684649460529, 12167.878321216851, 12172.087093468026, 12174.0, 12190.963768079635, 5135.768890399941, 5817.7963771267805, 5891.05743081105, 5988.0, 6030.427109424598, 5241.449647786927, 5384.434634363413, 5420.728963551806, 5467.0705979983495, 5490.3411590609385, 3324.3849887770357, 3540.6282340354405, 3804.087019115392, 3949.229900169497, 3978.224246272007, 1034.110664828262, 1036.6734478639355, 1039.365986748083, 1039.823230050878, 1059.9841002384971, 799.2447137455165, 840.1598401598402, 842.9884139033185, 862.1895418306772, 884.4472204871955, 6801.727930882808, 6845.247022827485, 6902.413294869993, 6982.581045137206, 7061.505694601328, 989.124624707125, 1038.5015192707392, 1041.7916416716687, 1048.3238311289176, 1058.8987453048896, 4246.596573325529, 4365.497967733688, 4509.661775366795, 4514.458265008155, 4528.456585209796, 13587.796183057262, 14173.291335433187, 14198.00613957013, 14206.928965355108, 14219.64450888736, 13404.32978351098, 13532.188068715908, 13868.514601988882, 13905.930470347583, 14100.36548355306, 10147.0, 10412.531436085394, 10426.843597346198, 10444.895551044545, 10487.790244195074, 6725.8991115134295, 6737.696803643946, 7084.822879427849, 7116.35952764233, 7246.6376681166785, 10204.591816327264, 12185.817212741638, 12741.362931853555, 12762.106652534234, 12772.169808962388, 12772.552960646333, 12800.35998200105, 12888.355582221038, 12898.226106433644, 13030.609081727564, 9528.761780955254, 9659.372140811105, 9705.854412183964, 9743.902560974582, 9760.560774765294, 10416.739581510523, 10614.0447359738, 10653.307535010199, 10653.520591573242, 10679.733006674895, 8327.50034997902, 8729.738107856774, 8846.778830529289, 8961.641534338554, 8962.193402593797, 6895.965520172367, 8785.0, 8818.426802257833, 8893.866592000995, 9075.909240907506, 8046.718364857202, 8212.83574328498, 8225.300849427866, 8226.753197404087, 8235.29999949987, 5979.671118088547, 5988.790392336247, 6043.516518678583, 6196.938030619816, 6198.349173336735, 6036.426539478743, 6175.567710260419, 6202.34875338101, 6229.595076320206, 6294.370562943669], "value": 5242.349805812751, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.973443123025, 345.939460594396, 382.6154714511915, 393.4079210787764, 397.79513550521466, 4528.909421811566, 4711.717296962184, 4915.283005681082, 5089.142463001006, 5143.248362126264, 4423.156643475398, 4978.626603004771, 5025.698458092517, 5032.82385116521, 5059.433099664737, 3445.431503801876, 3732.9066773330746, 3767.566729826078, 4209.85265515707, 4259.70182087254, 3610.855565777379, 3762.529683789526, 3790.9431358529505, 3990.321645320288, 4007.438958545806, 3771.5097037385103, 3790.5072340595684, 4243.893902652428, 4244.87265382039, 4283.057727299989, 3835.2137811748526, 4086.244044851712, 4154.987633965351, 4240.936385954213, 4449.332600109977, 3842.5965273646425, 3844.3464611016193, 3848.2688289224957, 3868.5763099656724, 3873.1602488817866, 4904.5831104356175, 4954.380702412199, 4955.975220123913, 4956.6282528810125, 4992.9251061233745, 4223.429836972, 4456.844010459651, 4587.449506059261, 4682.672212945095, 4929.827456039022, 4355.237833379146, 4667.809708524304, 5210.452902445227, 5226.92159617606, 5314.282571852789, 3646.835892384849, 3739.3082279778055, 4421.977890110561, 4422.292433210703, 4422.513523512411, 4335.0, 5458.808941687022, 5565.469495888622, 5828.0966450200285, 5923.985844812784, 3419.333230020172, 3784.905377365588, 4140.875773726793, 4391.389041506405, 4475.686701930834, 3615.421532554831, 4004.7196696231567, 4080.1227736036894, 4271.658267338606, 4564.954350456453, 4202.2646036943415, 4668.346431499593, 4800.279958006257, 4846.684965477303, 4911.950880491149, 4293.656507479394, 5247.816326428557, 5262.578993680497, 5391.595630327741, 5459.890802184013, 1305.4973835073374, 1355.9118657287443, 1361.6800051987775, 1514.2277438506221, 1516.9848301516843, 999.645125980281, 1092.2736380307165, 1148.8047032004579, 1170.4674373160362, 1180.2505409065304, 5001.873828856965, 5119.542619542566, 5153.201253805666, 5167.173252279617, 5167.534921857051, 4417.072414792865, 4978.8755281118265, 5434.755436005389, 5519.902437073966, 5533.0, 4731.550502702238, 4767.927903001071, 5087.2528834428995, 5172.267290457738, 5203.375594928632, 2662.201339598113, 2815.3806162644187, 2818.22498812824, 2872.7989040766947, 2873.6407949006375, 5732.426757324234, 5747.0, 5773.971130144322, 5775.5668324875805, 5815.389384114692, 4658.883527911829, 5383.43473935239, 5624.29696287964, 5695.515881150149, 5804.767809287581, 5075.720835354091, 5100.413452452867, 5269.130593452038, 5430.511253987082, 5785.508231800344, 4782.378290822171, 5225.1378522543355, 5288.963748956602, 5627.7900251446135, 5702.458266464845, 4740.3837501124635, 4930.334404855299, 5264.684118952875, 5323.574114070942, 5392.379876314274, 5207.869803254949, 5405.729713514387, 5422.267993820784, 5759.308882934075, 5772.7690892363835, 3853.672437842815, 3962.980185099056, 4056.350983842689, 4380.912381752283, 4431.892026993251, 4942.901141977212, 5157.530103920365, 5254.448282930391, 5475.808346707846, 5624.831255062355, 4819.662623616313, 4986.750662466935, 5251.501107394792, 5346.625736198429, 5373.017975023899, 4573.634109271316, 5380.874554550852, 5410.161424979135, 5420.810271640474, 5522.968233189714, 4654.627629789541, 4713.434387873477, 4722.811087556596, 4992.500749924979, 5246.30455742101, 5196.766145523537, 5350.191149646466, 5356.678599284055, 5361.597880158925, 5363.390982705251, 4443.977780111208, 4861.368022157097, 4878.56092951636, 5290.497402746733, 5353.946460535501], "value": 4081.148834651945, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [757.3713817531446, 778.6145857800383, 807.0517142357731, 896.1533881148026, 904.1546154345688, 15630.843691563081, 16463.670726585475, 17173.82826171738, 17700.203490842912, 17722.822771772277, 15756.76364854528, 15914.204289785523, 15966.28151733172, 16156.03063816172, 16455.2595133219, 971.8785151856018, 978.9021097890226, 981.8723565936453, 982.4841957972086, 982.7150126463317, 973.0707174648229, 975.5317447625144, 986.9753256168617, 986.9883369546201, 996.9850452243222, 982.4722556424757, 1024.6567399921034, 1027.291169093327, 1027.650598796409, 1028.850816631588, 895.4850960697624, 995.0348162282575, 1021.3310281765456, 1021.5658345203296, 1021.836506159011, 761.6648674583221, 762.3443838299058, 762.3977058124075, 762.6072572625103, 764.6673696941848, 16736.916315418344, 16913.408030718867, 16953.067581283147, 17549.56126096845, 17839.286428542844, 14018.929905350407, 14218.644533886632, 14285.000049996504, 14292.785608215885, 14308.427662893471, 10767.676969690921, 11339.072357699211, 12160.574379896661, 12200.816987745191, 12717.554885579053, 3830.3296923038356, 3883.2815929053218, 3942.4283478895686, 4021.577734337882, 4032.697547683935, 114803.0, 120356.19465708021, 121765.0, 122104.0, 123339.0, 11286.774264514828, 11446.313221206754, 11509.827352589718, 11692.240004399688, 11916.46375913086, 24251.15120970793, 24320.391990200034, 24580.877095614407, 24598.385040374134, 24639.26082217536, 7122.679479423438, 8133.877991830127, 8163.79590510242, 8242.670293188325, 8245.670173193124, 4632.86101416958, 4634.351190833286, 4686.74222917736, 4727.669063165614, 4922.941567562991, 3522.753407261467, 3624.3657359961903, 3636.1818590816856, 3644.781313121221, 3651.397519409321, 527.4093015822227, 655.3446553446554, 697.5849369625065, 772.2702046566053, 778.6956847280782, 565.7623798004848, 586.8151532267323, 605.2162449627742, 628.5129025005566, 652.9183852018498, 9103.772405689911, 9740.415575065377, 9972.401655900669, 10545.630902918361, 10987.340759554452, 717.9832999464454, 729.7227053719658, 737.2295950731499, 748.0163584885858, 750.3996802557932, 5128.8717782055, 5196.685303514422, 5253.973730131402, 5302.260573048565, 5310.495502927216, 88112.55943720369, 90642.54678726564, 90798.54600727087, 96135.51932240294, 105202.0, 63900.36099639037, 83570.0, 86045.569772152, 87047.56476217705, 89626.55186724024, 69519.65240173767, 70549.0, 73600.63199683861, 76310.0, 81659.18340816516, 10694.83957740619, 11282.830757538808, 11402.486888090221, 11411.771764564828, 11541.826872597087, 50070.0, 50732.49267507425, 52405.47594524158, 52651.73674131605, 54348.0, 63879.680601596694, 65088.0, 65176.67411662911, 65396.0, 65669.0, 13251.536196233086, 13429.932850335686, 13487.123336983064, 13491.0, 14062.367193476523, 14873.628159296104, 14877.0, 14982.625434364229, 15664.373425063326, 16094.597635059217, 13656.53637275217, 13767.311634418038, 14476.855231447971, 14684.045537040058, 15024.849751502783, 13731.271796560335, 13944.0, 14151.929240353733, 14634.268286585415, 14652.135293471843, 13437.0, 13965.162090274209, 14113.717725645634, 14133.0, 14290.928545357207, 9690.612375504901, 10133.18934485254, 10321.535530900977, 10367.94816025915, 10378.325408848703, 11266.324020558794, 11559.364234967157, 11629.360385178896, 11639.243449176116, 11659.18385712992], "value": 7914.550107786783, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1433.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 115.0, 115.0, 116.0, 116.0, 115.0, 115.0, 115.0, 117.0], "value": 114.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 105.0, 106.0, 138.0, 108.0, 105.0, 107.0, 104.0, 123.0, 107.0], "value": 113.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 184.0, 186.0, 183.0, 187.0, 186.0, 184.0, 195.0, 262.0, 206.0], "value": 195.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 80.0, 60.0, 65.0, 81.0, 84.0, 100.0, 61.0], "value": 73.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 69.0, 87.0, 69.0, 73.0, 93.0, 114.0, 99.0, 67.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 89.0, 88.0, 88.0, 89.0, 87.0, 90.0, 89.0, 88.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0, 95.0, 105.0, 151.0], "value": 101.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 81.0, 87.0, 85.0, 87.0, 86.0, 85.0, 83.0, 87.0, 83.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 59.0, 59.0, 60.0, 62.0, 63.0, 63.0, 62.0, 63.0, 64.0], "value": 61.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 71.0, 65.0, 61.0, 58.0, 59.0, 57.0, 59.0, 58.0], "value": 60.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 80.0, 89.0, 99.0, 98.0, 99.0, 84.0, 83.0, 80.0, 89.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 134.0, 132.0, 134.0, 141.0, 134.0, 154.0, 147.0, 181.0, 129.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 184.0, 163.0, 162.0, 161.0, 159.0, 162.0, 160.0, 159.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 63.0, 64.0, 63.0, 62.0, 63.0, 62.0], "value": 63.3, "unit": "score"}]}]} 09:02:30 INFO - Return code: 0 09:02:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:30 INFO - # TBPL SUCCESS # 09:02:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:02:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:02:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:02:30 INFO - 2017-05-03 09:02:30.598 screenresolution[3283:52251] starting screenresolution argv=screenresolution get 09:02:30 INFO - 2017-05-03 09:02:30.600 screenresolution[3283:52251] Display 0: 1600x1200x32@60 09:02:30 INFO - 2017-05-03 09:02:30.607 screenresolution[3284:52254] starting screenresolution argv=screenresolution list 09:02:30 INFO - Available Modes on Display 0 09:02:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:02:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:02:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:02:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:02:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:02:30 INFO - Intel Iris: 09:02:30 INFO - Chipset Model: Intel Iris 09:02:30 INFO - Type: GPU 09:02:30 INFO - Bus: Built-In 09:02:30 INFO - VRAM (Dynamic, Max): 1536 MB 09:02:30 INFO - Vendor: Intel (0x8086) 09:02:30 INFO - Device ID: 0x0a2e 09:02:30 INFO - Revision ID: 0x0009 09:02:30 INFO - Displays: 09:02:30 INFO - Display: 09:02:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:02:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:02:30 INFO - Display Serial Number: 1600x1200 60 09:02:30 INFO - Main Display: Yes 09:02:30 INFO - Mirror: Off 09:02:30 INFO - Online: Yes 09:02:30 INFO - Rotation: Supported 09:02:30 INFO - Return code: 0 09:02:30 INFO - Running post-action listener: _resource_record_post_action 09:02:30 INFO - [mozharness: 2017-05-03 16:02:30.844285Z] Finished run-tests step (success) 09:02:30 INFO - Running post-run listener: _resource_record_post_run 09:02:30 INFO - Total resource usage - Wall time: 1193s; CPU: 54.0%; Read bytes: 1355776; Write bytes: 421373952; Read time: 8; Write time: 1705 09:02:30 INFO - TinderboxPrint: CPU usage
53.8% 09:02:30 INFO - TinderboxPrint: I/O read bytes / time
1,355,776 / 8 09:02:30 INFO - TinderboxPrint: I/O write bytes / time
421,373,952 / 1,705 09:02:30 INFO - TinderboxPrint: CPU idle
2,206.7 (46.2%) 09:02:30 INFO - TinderboxPrint: CPU system
953.9 (20.0%) 09:02:30 INFO - TinderboxPrint: CPU user
1,613.1 (33.8%) 09:02:30 INFO - TinderboxPrint: Swap in / out
122,679,296 / 0 09:02:30 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122716672; Write bytes: 120270848; Read time: 11098; Write time: 369 09:02:30 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 376832; Write bytes: 297179136; Read time: 3; Write time: 1312 09:02:31 INFO - Running post-run listener: _upload_blobber_files 09:02:31 INFO - Blob upload gear active. 09:02:31 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:31 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:02:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:31 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:02:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:02:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:32 INFO - (blobuploader) - INFO - Done attempting. 09:02:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:02:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:02:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:34 INFO - (blobuploader) - INFO - Done attempting. 09:02:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:02:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:35 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:02:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:35 INFO - (blobuploader) - INFO - Done attempting. 09:02:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:37 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:02:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:37 INFO - (blobuploader) - INFO - Done attempting. 09:02:37 INFO - (blobuploader) - INFO - Iteration through files over. 09:02:37 INFO - Return code: 0 09:02:37 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:02:37 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:02:37 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28f9face4b72b8ed5a5b693d4b2bbf865b16b3baa20ae3e8a9220b954eb5a8d48edad4290990028090b0587e7d3147ad2e97971040de7d955aa3d8daa732714f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc16fb70f2938f26585b3cf4a6f3d0bb446fa7b1e6266f88187b3c1dd87852c4c5b10bfca23dada30bb10205f531b58e4a43bf5cd479feacb75cf92f5c746cc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce3ef7dc7ecb83db0b6d055f5e23782d91b54c66772ef11984426c7ecc80b2c921de20a28b273a5cc64cd7cf7cb8a4c47c89d7b5b17dfedecff74df8b8d8e7b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d42ecf00366ca170fee796aebb995922ce3e9bdb557342189ad695094a23cbb50a9522efaadbce6574036dad93a6cab6e277210499416ad92e388839c326a9a"} 09:02:37 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:02:37 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:02:37 INFO - Contents: 09:02:37 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28f9face4b72b8ed5a5b693d4b2bbf865b16b3baa20ae3e8a9220b954eb5a8d48edad4290990028090b0587e7d3147ad2e97971040de7d955aa3d8daa732714f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc16fb70f2938f26585b3cf4a6f3d0bb446fa7b1e6266f88187b3c1dd87852c4c5b10bfca23dada30bb10205f531b58e4a43bf5cd479feacb75cf92f5c746cc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce3ef7dc7ecb83db0b6d055f5e23782d91b54c66772ef11984426c7ecc80b2c921de20a28b273a5cc64cd7cf7cb8a4c47c89d7b5b17dfedecff74df8b8d8e7b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d42ecf00366ca170fee796aebb995922ce3e9bdb557342189ad695094a23cbb50a9522efaadbce6574036dad93a6cab6e277210499416ad92e388839c326a9a"} 09:02:37 INFO - Running post-run listener: copy_logs_to_upload_dir 09:02:37 INFO - Copying logs to upload dir... 09:02:37 INFO - mkdir: /builds/slave/test/build/upload/logs 09:02:37 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.640290 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2017-05-03 09:02:37.374085) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 09:02:37.378073) ========= 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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28f9face4b72b8ed5a5b693d4b2bbf865b16b3baa20ae3e8a9220b954eb5a8d48edad4290990028090b0587e7d3147ad2e97971040de7d955aa3d8daa732714f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc16fb70f2938f26585b3cf4a6f3d0bb446fa7b1e6266f88187b3c1dd87852c4c5b10bfca23dada30bb10205f531b58e4a43bf5cd479feacb75cf92f5c746cc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce3ef7dc7ecb83db0b6d055f5e23782d91b54c66772ef11984426c7ecc80b2c921de20a28b273a5cc64cd7cf7cb8a4c47c89d7b5b17dfedecff74df8b8d8e7b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d42ecf00366ca170fee796aebb995922ce3e9bdb557342189ad695094a23cbb50a9522efaadbce6574036dad93a6cab6e277210499416ad92e388839c326a9a"} build_url:https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011299 build_url: 'https://queue.taskcluster.net/v1/task/co4XO3LtQx6EXGPRX_XbTg/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28f9face4b72b8ed5a5b693d4b2bbf865b16b3baa20ae3e8a9220b954eb5a8d48edad4290990028090b0587e7d3147ad2e97971040de7d955aa3d8daa732714f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cc16fb70f2938f26585b3cf4a6f3d0bb446fa7b1e6266f88187b3c1dd87852c4c5b10bfca23dada30bb10205f531b58e4a43bf5cd479feacb75cf92f5c746cc6", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ce3ef7dc7ecb83db0b6d055f5e23782d91b54c66772ef11984426c7ecc80b2c921de20a28b273a5cc64cd7cf7cb8a4c47c89d7b5b17dfedecff74df8b8d8e7b9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0d42ecf00366ca170fee796aebb995922ce3e9bdb557342189ad695094a23cbb50a9522efaadbce6574036dad93a6cab6e277210499416ad92e388839c326a9a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-03 09:02:37.412871) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 09:02:37.413192) ========= 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.UBzwQ8VXf2/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.BsNXkWrKc8/Listeners TMPDIR=/var/folders/s6/nd6_75rn093bvthhj7zyph6r00000w/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.005185 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-03 09:02:37.461472) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 09:02:37.461793) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-03 09:02:37.462227) ========= ========= Total master_lag: 0.18 =========