builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0032 starttime: 1494333492.39 results: success (0) buildid: 20170509041042 builduid: 8467ec270b874fb4a70760673eb7fe35 revision: ffb4bf982bebe22f9250869885fb1388dc4539c5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:12.394159) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:12.394720) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:12.395090) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:12.423179) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:12.423620) ========= 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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-09 05:38:12-- 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% 9.76M=0.001s 2017-05-09 05:38:12 (9.76 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094960 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:12.543437) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:12.543768) ========= 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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.027079 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:12.593661) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-05-09 05:38:12.594020) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev ffb4bf982bebe22f9250869885fb1388dc4539c5 --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 ffb4bf982bebe22f9250869885fb1388dc4539c5 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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-09 05:38:12,691 truncating revision to first 12 chars 2017-05-09 05:38:12,691 Setting DEBUG logging. 2017-05-09 05:38:12,691 attempt 1/10 2017-05-09 05:38:12,691 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/ffb4bf982beb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-09 05:38:15,530 unpacking tar archive at: mozilla-beta-ffb4bf982beb/testing/mozharness/ program finished with exit code 0 elapsedTime=3.112878 ========= master_lag: 2.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 5 secs) (at 2017-05-09 05:38:17.767613) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:17.767991) ========= script_repo_revision: ffb4bf982bebe22f9250869885fb1388dc4539c5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:17.768401) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:17.768700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-09 05:38:17.790806) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-05-09 05:38:17.791214) ========= /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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:38:17 INFO - MultiFileLogger online at 20170509 05:38:17 in /builds/slave/test 05:38:17 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 05:38:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:38:17 INFO - {'append_to_log': False, 05:38:17 INFO - 'base_work_dir': '/builds/slave/test', 05:38:17 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:38:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:38:17 INFO - 'branch': 'Mozilla-Beta', 05:38:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:38:17 INFO - 'config_files': ('talos/mac_config.py',), 05:38:17 INFO - 'default_actions': ('clobber', 05:38:17 INFO - 'read-buildbot-config', 05:38:17 INFO - 'download-and-extract', 05:38:17 INFO - 'populate-webroot', 05:38:17 INFO - 'create-virtualenv', 05:38:17 INFO - 'install', 05:38:17 INFO - 'run-tests'), 05:38:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:38:17 INFO - 'download_minidump_stackwalk': True, 05:38:17 INFO - 'download_symbols': 'ondemand', 05:38:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:38:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:38:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:38:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:38:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:38:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:38:17 INFO - 'gecko_profile': False, 05:38:17 INFO - 'gecko_profile_interval': 0, 05:38:17 INFO - 'installer_path': 'installer.exe', 05:38:17 INFO - 'log_level': 'info', 05:38:17 INFO - 'log_name': 'talos', 05:38:17 INFO - 'log_to_console': True, 05:38:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:38:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:38:17 INFO - 'opt_config_files': (), 05:38:17 INFO - 'pip_index': False, 05:38:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:38:17 INFO - 'cmd': ('bash', 05:38:17 INFO - '-c', 05:38:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:38:18 INFO - 'enabled': True, 05:38:18 INFO - 'halt_on_failure': False, 05:38:18 INFO - 'name': 'check_screen_resolution'},), 05:38:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:38:18 INFO - 'cmd': ('bash', 05:38:18 INFO - '-c', 05:38:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:38:18 INFO - 'enabled': True, 05:38:18 INFO - 'halt_on_failure': False, 05:38:18 INFO - 'name': 'check_screen_resolution'},), 05:38:18 INFO - 'run_cmd_checks_enabled': True, 05:38:18 INFO - 'suite': 'dromaeojs', 05:38:18 INFO - 'system_bits': '32', 05:38:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:38:18 INFO - 'title': 't-yosemite-r7-0032', 05:38:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:38:18 INFO - 'use_talos_json': True, 05:38:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:38:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:38:18 INFO - 'work_dir': 'build'} 05:38:18 INFO - [mozharness: 2017-05-09 12:38:18.002181Z] Running clobber step. 05:38:18 INFO - Running pre-action listener: _resource_record_pre_action 05:38:18 INFO - Running main action method: clobber 05:38:18 INFO - rmtree: /builds/slave/test/build 05:38:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:38:20 INFO - Running post-action listener: _resource_record_post_action 05:38:20 INFO - [mozharness: 2017-05-09 12:38:20.522653Z] Finished clobber step (success) 05:38:20 INFO - [mozharness: 2017-05-09 12:38:20.522781Z] Running read-buildbot-config step. 05:38:20 INFO - Running pre-action listener: _resource_record_pre_action 05:38:20 INFO - Running main action method: read_buildbot_config 05:38:20 INFO - Using buildbot properties: 05:38:20 INFO - { 05:38:20 INFO - "project": "", 05:38:20 INFO - "product": "firefox", 05:38:20 INFO - "script_repo_revision": "production", 05:38:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:38:20 INFO - "repository": "", 05:38:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:38:20 INFO - "buildid": "20170509041042", 05:38:20 INFO - "pgo_build": "False", 05:38:20 INFO - "basedir": "/builds/slave/test", 05:38:20 INFO - "buildnumber": 23, 05:38:20 INFO - "slavename": "t-yosemite-r7-0032", 05:38:20 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:38:20 INFO - "platform": "yosemite_r7", 05:38:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:38:20 INFO - "branch": "mozilla-beta", 05:38:20 INFO - "repo_path": "releases/mozilla-beta", 05:38:20 INFO - "revision": "ffb4bf982bebe22f9250869885fb1388dc4539c5", 05:38:20 INFO - "stage_platform": "macosx64", 05:38:20 INFO - "builduid": "8467ec270b874fb4a70760673eb7fe35", 05:38:20 INFO - "slavebuilddir": "test" 05:38:20 INFO - } 05:38:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 05:38:20 INFO - Running post-action listener: _resource_record_post_action 05:38:20 INFO - [mozharness: 2017-05-09 12:38:20.525974Z] Finished read-buildbot-config step (success) 05:38:20 INFO - [mozharness: 2017-05-09 12:38:20.526076Z] Running download-and-extract step. 05:38:20 INFO - Running pre-action listener: _resource_record_pre_action 05:38:20 INFO - Running main action method: download_and_extract 05:38:20 INFO - mkdir: /builds/slave/test/build/tests 05:38:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:20 INFO - trying https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 05:38:20 INFO - Downloading https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/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 05:38:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/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 05:38:21 INFO - Downloaded 1287 bytes. 05:38:21 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 05:38:21 INFO - Using the following test package requirements: 05:38:21 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 05:38:21 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 05:38:21 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 05:38:21 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 05:38:21 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:38:21 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 05:38:21 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 05:38:21 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 05:38:21 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 05:38:21 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 05:38:21 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 05:38:21 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 05:38:21 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 05:38:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 05:38:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 05:38:21 INFO - Fetch https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 05:38:23 INFO - Expected file size: 51227026 05:38:23 INFO - Obtained file size: 51227026 05:38:39 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 05:38:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 05:38:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 05:38:39 INFO - Fetch https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 05:38:41 INFO - Expected file size: 51227026 05:38:41 INFO - Obtained file size: 51227026 05:38:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 05:38:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 05:38:56 INFO - Fetch https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 05:38:57 INFO - Expected file size: 14404449 05:38:57 INFO - Obtained file size: 14404449 05:38:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:38:58 INFO - trying https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 05:38:58 INFO - Downloading https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 05:38:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/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 05:39:00 INFO - Downloaded 59570320 bytes. 05:39:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 05:39:00 INFO - mkdir: /builds/slave/test/properties 05:39:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:39:00 INFO - Writing to file /builds/slave/test/properties/build_url 05:39:00 INFO - Contents: 05:39:00 INFO - build_url:https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 05:39:00 INFO - Running post-action listener: _resource_record_post_action 05:39:00 INFO - Running post-action listener: set_extra_try_arguments 05:39:00 INFO - [mozharness: 2017-05-09 12:39:00.971483Z] Finished download-and-extract step (success) 05:39:00 INFO - [mozharness: 2017-05-09 12:39:00.971597Z] Running populate-webroot step. 05:39:00 INFO - Running pre-action listener: _resource_record_pre_action 05:39:00 INFO - Running main action method: populate_webroot 05:39:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:39:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:39:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:39:00 INFO - '--tppagecycles', 05:39:00 INFO - '7'], 05:39:00 INFO - 'tests': ['tsvgm']}}, 05:39:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:39:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:39:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:39:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:39:00 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:39:00 INFO - 'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:00 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:39:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:39:00 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:39:00 INFO - 'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['damp', 'tps']}, 05:39:00 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:39:00 INFO - 'tests': ['damp', 'tps']}, 05:39:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['dromaeo_dom']}, 05:39:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:39:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['basic_compositor_video']}, 05:39:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:39:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['a11yr', 05:39:00 INFO - 'ts_paint', 05:39:00 INFO - 'tpaint', 05:39:00 INFO - 'sessionrestore', 05:39:00 INFO - 'sessionrestore_no_auto_restore', 05:39:00 INFO - 'tabpaint']}, 05:39:00 INFO - 'other-e10s': {'tests': ['a11yr', 05:39:00 INFO - 'ts_paint', 05:39:00 INFO - 'tpaint', 05:39:00 INFO - 'sessionrestore', 05:39:00 INFO - 'sessionrestore_no_auto_restore', 05:39:00 INFO - 'tabpaint']}, 05:39:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:39:00 INFO - 'ts_paint', 05:39:00 INFO - 'tpaint', 05:39:00 INFO - 'sessionrestore', 05:39:00 INFO - 'sessionrestore_no_auto_restore', 05:39:00 INFO - 'tabpaint']}, 05:39:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:39:00 INFO - 'ts_paint', 05:39:00 INFO - 'tpaint', 05:39:00 INFO - 'sessionrestore', 05:39:00 INFO - 'sessionrestore_no_auto_restore', 05:39:00 INFO - 'tabpaint']}, 05:39:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['a11yr', 05:39:00 INFO - 'ts_paint', 05:39:00 INFO - 'tpaint', 05:39:00 INFO - 'sessionrestore', 05:39:00 INFO - 'sessionrestore_no_auto_restore', 05:39:00 INFO - 'tabpaint']}, 05:39:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['a11yr', 05:39:00 INFO - 'ts_paint', 05:39:00 INFO - 'tpaint', 05:39:00 INFO - 'sessionrestore', 05:39:00 INFO - 'sessionrestore_no_auto_restore', 05:39:00 INFO - 'tabpaint']}, 05:39:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['tsvgx', 05:39:00 INFO - 'tsvgr_opacity', 05:39:00 INFO - 'tart', 05:39:00 INFO - 'tscrollx', 05:39:00 INFO - 'cart', 05:39:00 INFO - 'tsvg_static']}, 05:39:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:39:00 INFO - 'tsvgr_opacity', 05:39:00 INFO - 'tart', 05:39:00 INFO - 'tscrollx', 05:39:00 INFO - 'cart', 05:39:00 INFO - 'tsvg_static']}, 05:39:00 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:39:00 INFO - 'talos_options': ['--disable-e10s'], 05:39:00 INFO - 'tests': ['tp5o']}, 05:39:00 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:39:00 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:39:00 INFO - 'talos_options': ['--disable-e10s', 05:39:00 INFO - '--xperf_path', 05:39:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:00 INFO - 'tests': ['tp5n']}, 05:39:00 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:39:00 INFO - 'talos_options': ['--xperf_path', 05:39:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:39:00 INFO - 'tests': ['tp5n']}}, 05:39:00 INFO - 'talos.zip': {'path': '', 05:39:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:39:00 INFO - Running post-action listener: _resource_record_post_action 05:39:00 INFO - [mozharness: 2017-05-09 12:39:00.989908Z] Finished populate-webroot step (success) 05:39:00 INFO - [mozharness: 2017-05-09 12:39:00.990045Z] Running create-virtualenv step. 05:39:00 INFO - Running pre-action listener: _resource_record_pre_action 05:39:00 INFO - Running main action method: create_virtualenv 05:39:00 INFO - Creating virtualenv /builds/slave/test/build/venv 05:39:00 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 05:39:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:39:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:39:01 INFO - Using real prefix '/tools/python27' 05:39:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:39:01 INFO - Installing distribute.............................................................................................................................................................................................done. 05:39:04 INFO - Installing pip.................done. 05:39:04 INFO - Return code: 0 05:39:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:39:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:39:04 INFO - Reading from file tmpfile_stdout 05:39:04 INFO - Output received: 05:39:04 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) 05:39:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:39:04 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')]} 05:39:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:04 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')]} 05:39:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:04 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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39:04 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 05:39:04 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 05:39:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:04 INFO - 'HOME': '/Users/cltbld', 05:39:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:04 INFO - 'LOGNAME': 'cltbld', 05:39:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:04 INFO - 'MOZ_NO_REMOTE': '1', 05:39:04 INFO - 'NO_EM_RESTART': '1', 05:39:04 INFO - 'PAGER': '/bin/cat', 05:39:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:04 INFO - 'PWD': '/builds/slave/test', 05:39:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:04 INFO - 'SHELL': '/bin/bash', 05:39:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:04 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:04 INFO - 'USER': 'cltbld', 05:39:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:04 INFO - 'XPC_FLAGS': '0x0', 05:39:04 INFO - 'XPC_SERVICE_NAME': '0', 05:39:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:05 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 05:39:05 INFO - Cleaning up... 05:39:05 INFO - Return code: 0 05:39:05 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:39:05 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')]} 05:39:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:05 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')]} 05:39:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:05 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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39:05 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 05:39:05 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 05:39:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:05 INFO - 'HOME': '/Users/cltbld', 05:39:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:05 INFO - 'LOGNAME': 'cltbld', 05:39:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:05 INFO - 'MOZ_NO_REMOTE': '1', 05:39:05 INFO - 'NO_EM_RESTART': '1', 05:39:05 INFO - 'PAGER': '/bin/cat', 05:39:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:05 INFO - 'PWD': '/builds/slave/test', 05:39:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:05 INFO - 'SHELL': '/bin/bash', 05:39:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:05 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:05 INFO - 'USER': 'cltbld', 05:39:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:05 INFO - 'XPC_FLAGS': '0x0', 05:39:05 INFO - 'XPC_SERVICE_NAME': '0', 05:39:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:05 INFO - Downloading/unpacking psutil>=3.1.1 05:39:05 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 05:39:05 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 05:39:05 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 05:39:05 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 05:39:05 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 05:39:05 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 05:39:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:39:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:07 INFO - Installing collected packages: psutil 05:39:07 INFO - Running setup.py install for psutil 05:39:07 INFO - building 'psutil._psutil_osx' extension 05:39:07 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 05:39:08 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 05:39:08 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 05:39:08 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 05:39:08 INFO - building 'psutil._psutil_posix' extension 05:39:08 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 05:39:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:39:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:39:08 INFO - ^ 05:39:08 INFO - 1 warning generated. 05:39:08 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 05:39:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:39:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:39:08 INFO - Successfully installed psutil 05:39:08 INFO - Cleaning up... 05:39:08 INFO - Return code: 0 05:39:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:39:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:09 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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39:09 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 05:39:09 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 05:39:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:09 INFO - 'HOME': '/Users/cltbld', 05:39:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:09 INFO - 'LOGNAME': 'cltbld', 05:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:09 INFO - 'MOZ_NO_REMOTE': '1', 05:39:09 INFO - 'NO_EM_RESTART': '1', 05:39:09 INFO - 'PAGER': '/bin/cat', 05:39:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:09 INFO - 'PWD': '/builds/slave/test', 05:39:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:09 INFO - 'SHELL': '/bin/bash', 05:39:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:09 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:09 INFO - 'USER': 'cltbld', 05:39:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:09 INFO - 'XPC_FLAGS': '0x0', 05:39:09 INFO - 'XPC_SERVICE_NAME': '0', 05:39:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:39:10 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 05:39:10 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 05:39:10 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 05:39:10 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 05:39:10 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 05:39:10 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 05:39:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:39:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:39:11 INFO - Installing collected packages: mozsystemmonitor 05:39:11 INFO - Running setup.py install for mozsystemmonitor 05:39:11 INFO - Successfully installed mozsystemmonitor 05:39:11 INFO - Cleaning up... 05:39:11 INFO - Return code: 0 05:39:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:39:11 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')]} 05:39:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:11 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')]} 05:39:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:12 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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39:12 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 05:39:12 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 05:39:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:12 INFO - 'HOME': '/Users/cltbld', 05:39:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:12 INFO - 'LOGNAME': 'cltbld', 05:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:12 INFO - 'MOZ_NO_REMOTE': '1', 05:39:12 INFO - 'NO_EM_RESTART': '1', 05:39:12 INFO - 'PAGER': '/bin/cat', 05:39:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:12 INFO - 'PWD': '/builds/slave/test', 05:39:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:12 INFO - 'SHELL': '/bin/bash', 05:39:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:12 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:12 INFO - 'USER': 'cltbld', 05:39:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:12 INFO - 'XPC_FLAGS': '0x0', 05:39:12 INFO - 'XPC_SERVICE_NAME': '0', 05:39:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:12 INFO - Downloading/unpacking jsonschema==2.5.1 05:39:12 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 05:39:12 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 05:39:12 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 05:39:12 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 05:39:12 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 05:39:12 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 05:39:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:39:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:39:13 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 05:39:13 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 05:39:13 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 05:39:13 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 05:39:13 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 05:39:13 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 05:39:13 INFO - Downloading functools32-3.2.3-2.tar.gz 05:39:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:39:14 INFO - warning: no files found matching '*.txt' 05:39:14 INFO - no previously-included directories found matching 'build' 05:39:14 INFO - no previously-included directories found matching 'dist' 05:39:14 INFO - no previously-included directories found matching '.git*' 05:39:14 INFO - Installing collected packages: jsonschema, functools32 05:39:14 INFO - Running setup.py install for functools32 05:39:14 INFO - warning: no files found matching '*.txt' 05:39:14 INFO - no previously-included directories found matching 'build' 05:39:14 INFO - no previously-included directories found matching 'dist' 05:39:14 INFO - no previously-included directories found matching '.git*' 05:39:14 INFO - Successfully installed jsonschema functools32 05:39:14 INFO - Cleaning up... 05:39:14 INFO - Return code: 0 05:39:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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', '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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:39: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 functools32==3.2.3-2 05:39:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:14 INFO - 'HOME': '/Users/cltbld', 05:39:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:14 INFO - 'LOGNAME': 'cltbld', 05:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:14 INFO - 'MOZ_NO_REMOTE': '1', 05:39:14 INFO - 'NO_EM_RESTART': '1', 05:39:14 INFO - 'PAGER': '/bin/cat', 05:39:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:14 INFO - 'PWD': '/builds/slave/test', 05:39:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:14 INFO - 'SHELL': '/bin/bash', 05:39:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:14 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:14 INFO - 'USER': 'cltbld', 05:39:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:14 INFO - 'XPC_FLAGS': '0x0', 05:39:14 INFO - 'XPC_SERVICE_NAME': '0', 05:39:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:39:14 INFO - Cleaning up... 05:39:14 INFO - Return code: 0 05:39:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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', '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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:39: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 blobuploader==1.2.4 05:39:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:14 INFO - 'HOME': '/Users/cltbld', 05:39:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:14 INFO - 'LOGNAME': 'cltbld', 05:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:14 INFO - 'MOZ_NO_REMOTE': '1', 05:39:14 INFO - 'NO_EM_RESTART': '1', 05:39:14 INFO - 'PAGER': '/bin/cat', 05:39:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:14 INFO - 'PWD': '/builds/slave/test', 05:39:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:14 INFO - 'SHELL': '/bin/bash', 05:39:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:14 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:14 INFO - 'USER': 'cltbld', 05:39:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:14 INFO - 'XPC_FLAGS': '0x0', 05:39:14 INFO - 'XPC_SERVICE_NAME': '0', 05:39:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:14 INFO - Downloading/unpacking blobuploader==1.2.4 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39: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 05:39:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:39:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:39:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 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 05:39:16 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 05:39:17 INFO - Downloading docopt-0.6.1.tar.gz 05:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:39:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:39:17 INFO - Running setup.py install for blobuploader 05:39:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:39:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:39:17 INFO - Running setup.py install for requests 05:39:17 INFO - Running setup.py install for docopt 05:39:18 INFO - Successfully installed blobuploader requests docopt 05:39:18 INFO - Cleaning up... 05:39:18 INFO - Return code: 0 05:39:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:18 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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39:18 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 05:39:18 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 05:39:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:18 INFO - 'HOME': '/Users/cltbld', 05:39:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:18 INFO - 'LOGNAME': 'cltbld', 05:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:18 INFO - 'MOZ_NO_REMOTE': '1', 05:39:18 INFO - 'NO_EM_RESTART': '1', 05:39:18 INFO - 'PAGER': '/bin/cat', 05:39:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:18 INFO - 'PWD': '/builds/slave/test', 05:39:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:18 INFO - 'SHELL': '/bin/bash', 05:39:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:18 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:18 INFO - 'USER': 'cltbld', 05:39:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:18 INFO - 'XPC_FLAGS': '0x0', 05:39:18 INFO - 'XPC_SERVICE_NAME': '0', 05:39:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:18 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-MuQInq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:18 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-2ZZVQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:18 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-IoiLFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:18 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-VVxhPW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:18 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-VE75uF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:18 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-qRJFxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:18 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-BKzy2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-mE6llS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-BHHZxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-FX5IUN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-LkiYr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-RzOzoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-jRYnas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DRsdN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-oQdDr3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-DRbdpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:19 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vu8esP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:39:20 INFO - Running setup.py install for manifestparser 05:39:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:39:20 INFO - Running setup.py install for mozcrash 05:39:20 INFO - Running setup.py install for mozdebug 05:39:20 INFO - Running setup.py install for mozdevice 05:39:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:39:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:39:20 INFO - Running setup.py install for mozfile 05:39:20 INFO - Running setup.py install for mozhttpd 05:39:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:39:20 INFO - Running setup.py install for mozinfo 05:39:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:39:21 INFO - Running setup.py install for mozInstall 05:39:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:39:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:39:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:39:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:39:21 INFO - Running setup.py install for mozleak 05:39:21 INFO - Running setup.py install for mozlog 05:39:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:39:21 INFO - Running setup.py install for moznetwork 05:39:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:39:21 INFO - Running setup.py install for mozprocess 05:39:21 INFO - Running setup.py install for mozprofile 05:39:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:39:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:39:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:39:22 INFO - Running setup.py install for mozrunner 05:39:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:39:22 INFO - Running setup.py install for mozscreenshot 05:39:22 INFO - Running setup.py install for moztest 05:39:22 INFO - Running setup.py install for mozversion 05:39:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:39:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:39:22 INFO - Cleaning up... 05:39:22 INFO - Return code: 0 05:39:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:22 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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39:22 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 05:39:22 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 05:39:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:22 INFO - 'HOME': '/Users/cltbld', 05:39:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:22 INFO - 'LOGNAME': 'cltbld', 05:39:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:22 INFO - 'MOZ_NO_REMOTE': '1', 05:39:22 INFO - 'NO_EM_RESTART': '1', 05:39:22 INFO - 'PAGER': '/bin/cat', 05:39:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:22 INFO - 'PWD': '/builds/slave/test', 05:39:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:22 INFO - 'SHELL': '/bin/bash', 05:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:22 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:22 INFO - 'USER': 'cltbld', 05:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:22 INFO - 'XPC_FLAGS': '0x0', 05:39:22 INFO - 'XPC_SERVICE_NAME': '0', 05:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:39:22 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-WiMxUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:39:23 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)) 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:39:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-glN9Z_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:39:23 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)) 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:39:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-sH5eIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:39:23 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)) 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:39:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-vdwHn8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:39:23 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)) 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:39:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-voYGEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:39:23 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)) 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:39:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-iyDsHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:39:23 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)) 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:39:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-tpXXxx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:39:23 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)) 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:39:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-BdTFpr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:39:23 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)) 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:39:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-m92s0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:39:23 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)) 05:39:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:39:23 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-J_bkFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:39:24 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)) 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:39:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-LXSLr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:39:24 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)) 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:39:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-RRKdXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:39:24 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)) 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:39:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-umyyyN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:39:24 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)) 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:39:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-E9eiYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:39:24 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)) 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-PM7c4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:39:24 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)) 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:39:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-9x3BfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:39:24 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)) 05:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:39:24 INFO - Running setup.py (path:/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/pip-BjS8_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:39:24 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)) 05:39:24 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)) 05:39:24 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)) 05:39:24 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)) 05:39:24 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)) 05:39:24 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)) 05:39:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:39:24 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 05:39:24 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 05:39:24 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 05:39:24 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 05:39:24 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 05:39:24 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 05:39:26 INFO - Downloading blessings-1.6.tar.gz 05:39:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:39:26 INFO - Installing collected packages: blessings 05:39:26 INFO - Running setup.py install for blessings 05:39:26 INFO - Successfully installed blessings 05:39:26 INFO - Cleaning up... 05:39:26 INFO - Return code: 0 05:39:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:39:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:26 INFO - Reading from file tmpfile_stdout 05:39:26 INFO - Current package versions: 05:39:26 INFO - blessings == 1.6 05:39:26 INFO - blobuploader == 1.2.4 05:39:26 INFO - docopt == 0.6.1 05:39:26 INFO - functools32 == 3.2.3-2 05:39:26 INFO - jsonschema == 2.5.1 05:39:26 INFO - manifestparser == 1.1 05:39:26 INFO - mozInstall == 1.12 05:39:26 INFO - mozcrash == 1.0 05:39:26 INFO - mozdebug == 0.1 05:39:26 INFO - mozdevice == 0.49 05:39:26 INFO - mozfile == 1.2 05:39:26 INFO - mozhttpd == 0.7 05:39:26 INFO - mozinfo == 0.9 05:39:26 INFO - mozleak == 0.1 05:39:26 INFO - mozlog == 3.4 05:39:26 INFO - moznetwork == 0.27 05:39:26 INFO - mozprocess == 0.25 05:39:26 INFO - mozprofile == 0.28 05:39:26 INFO - mozrunner == 6.13 05:39:26 INFO - mozscreenshot == 0.1 05:39:26 INFO - mozsystemmonitor == 0.3 05:39:26 INFO - moztest == 0.8 05:39:26 INFO - mozversion == 1.4 05:39:26 INFO - psutil == 3.1.1 05:39:26 INFO - requests == 1.2.3 05:39:26 INFO - wsgiref == 0.1.2 05:39:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:39:26 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')]} 05:39:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:26 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')]} 05:39:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:26 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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39:26 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 05:39:26 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 05:39:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:26 INFO - 'HOME': '/Users/cltbld', 05:39:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:26 INFO - 'LOGNAME': 'cltbld', 05:39:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:26 INFO - 'MOZ_NO_REMOTE': '1', 05:39:26 INFO - 'NO_EM_RESTART': '1', 05:39:26 INFO - 'PAGER': '/bin/cat', 05:39:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:26 INFO - 'PWD': '/builds/slave/test', 05:39:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:26 INFO - 'SHELL': '/bin/bash', 05:39:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:26 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:26 INFO - 'USER': 'cltbld', 05:39:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:26 INFO - 'XPC_FLAGS': '0x0', 05:39:26 INFO - 'XPC_SERVICE_NAME': '0', 05:39:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:27 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)) 05:39:27 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)) 05:39:27 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)) 05:39:27 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)) 05:39:27 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)) 05:39:27 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)) 05:39:27 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)) 05:39:27 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)) 05:39:27 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)) 05:39:27 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)) 05:39:27 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)) 05:39:27 INFO - Cleaning up... 05:39:27 INFO - Return code: 0 05:39:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:39: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')]} 05:39:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:39:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39: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')]} 05:39:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:39:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:39:27 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 0x10d5bfb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5c2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb72bcce440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, '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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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 05:39:27 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 05:39:27 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 05:39:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:27 INFO - 'HOME': '/Users/cltbld', 05:39:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:27 INFO - 'LOGNAME': 'cltbld', 05:39:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:27 INFO - 'MOZ_NO_REMOTE': '1', 05:39:27 INFO - 'NO_EM_RESTART': '1', 05:39:27 INFO - 'PAGER': '/bin/cat', 05:39:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:27 INFO - 'PWD': '/builds/slave/test', 05:39:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:27 INFO - 'SHELL': '/bin/bash', 05:39:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:27 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:27 INFO - 'USER': 'cltbld', 05:39:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:27 INFO - 'XPC_FLAGS': '0x0', 05:39:27 INFO - 'XPC_SERVICE_NAME': '0', 05:39:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:39:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:39:27 INFO - Cleaning up... 05:39:27 INFO - Return code: 0 05:39:27 INFO - Running post-action listener: _resource_record_post_action 05:39:27 INFO - Running post-action listener: _start_resource_monitoring 05:39:27 INFO - Starting resource monitoring. 05:39:27 INFO - [mozharness: 2017-05-09 12:39:27.398310Z] Finished create-virtualenv step (success) 05:39:27 INFO - [mozharness: 2017-05-09 12:39:27.399260Z] Running install step. 05:39:27 INFO - Running pre-action listener: _resource_record_pre_action 05:39:27 INFO - Running main action method: install 05:39:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:39:27 INFO - Reading from file tmpfile_stdout 05:39:27 INFO - Detecting whether we're running mozinstall >=1.0... 05:39:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:39:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:39:27 INFO - Reading from file tmpfile_stdout 05:39:27 INFO - Output received: 05:39:27 INFO - Usage: mozinstall [options] installer 05:39:27 INFO - Options: 05:39:27 INFO - -h, --help show this help message and exit 05:39:27 INFO - -d DEST, --destination=DEST 05:39:27 INFO - Directory to install application into. [default: 05:39:27 INFO - "/builds/slave/test"] 05:39:27 INFO - --app=APP Application being installed. [default: firefox] 05:39:27 INFO - mkdir: /builds/slave/test/build/application 05:39:27 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'] 05:39:27 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 05:39:42 INFO - Reading from file tmpfile_stdout 05:39:42 INFO - Output received: 05:39:42 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:39:42 INFO - Running post-action listener: _resource_record_post_action 05:39:42 INFO - [mozharness: 2017-05-09 12:39:42.491752Z] Finished install step (success) 05:39:42 INFO - [mozharness: 2017-05-09 12:39:42.491878Z] Running run-tests step. 05:39:42 INFO - Running pre-action listener: _resource_record_pre_action 05:39:42 INFO - Running main action method: run_tests 05:39:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:39:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:39:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:39:42 INFO - 2017-05-09 05:39:42.506 screenresolution[1628:7429] starting screenresolution argv=screenresolution get 05:39:42 INFO - 2017-05-09 05:39:42.509 screenresolution[1628:7429] Display 0: 1600x1200x32@60 05:39:42 INFO - 2017-05-09 05:39:42.514 screenresolution[1629:7431] starting screenresolution argv=screenresolution list 05:39:42 INFO - Available Modes on Display 0 05:39:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:39:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:39:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:39:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:39:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:39:42 INFO - Intel Iris: 05:39:42 INFO - Chipset Model: Intel Iris 05:39:42 INFO - Type: GPU 05:39:42 INFO - Bus: Built-In 05:39:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:39:42 INFO - Vendor: Intel (0x8086) 05:39:42 INFO - Device ID: 0x0a2e 05:39:42 INFO - Revision ID: 0x0009 05:39:42 INFO - Displays: 05:39:42 INFO - Display: 05:39:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:39:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:39:42 INFO - Display Serial Number: 1600x1200 60 05:39:42 INFO - Main Display: Yes 05:39:42 INFO - Mirror: Off 05:39:42 INFO - Online: Yes 05:39:42 INFO - Rotation: Supported 05:39:42 INFO - Return code: 0 05:39:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:39:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:39:42 INFO - Python 2.7.3 05:39:42 INFO - Return code: 0 05:39:42 INFO - grabbing minidump binary from tooltool 05:39:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:39:42 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 0x10d39dd30>, '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 0x10d2c4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d392be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:39:42 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 05:39:42 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 05:39:42 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 05:39:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:39:42 INFO - Return code: 0 05:39:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:39:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:39:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:39:42 INFO - ENV: RUST_BACKTRACE is now 1 05:39:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:39:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:39:42 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/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 05:39:42 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/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0032 --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 05:39:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xXOUOB5Hpa/Render', 05:39:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:39:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:39:42 INFO - 'HOME': '/Users/cltbld', 05:39:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:39:42 INFO - 'LOGNAME': 'cltbld', 05:39:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:39:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:39:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:39:42 INFO - 'MOZ_NO_REMOTE': '1', 05:39:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:39:42 INFO - 'NO_EM_RESTART': '1', 05:39:42 INFO - 'PAGER': '/bin/cat', 05:39:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:39:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:39:42 INFO - 'PWD': '/builds/slave/test', 05:39:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:39:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:39:42 INFO - 'RUST_BACKTRACE': '1', 05:39:42 INFO - 'SHELL': '/bin/bash', 05:39:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xBOWTmP0EV/Listeners', 05:39:42 INFO - 'TMPDIR': '/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/', 05:39:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:39:42 INFO - 'USER': 'cltbld', 05:39:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:39:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:39:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:39:42 INFO - 'XPC_FLAGS': '0x0', 05:39:42 INFO - 'XPC_SERVICE_NAME': '0', 05:39:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:39:42 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/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0032', '--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 05:39:43 INFO - mozversion application_buildid: 20170509041042 05:39:43 INFO - mozversion application_changeset: ffb4bf982bebe22f9250869885fb1388dc4539c5 05:39:43 INFO - mozversion application_display_name: Firefox 05:39:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:39:43 INFO - mozversion application_name: Firefox 05:39:43 INFO - mozversion application_remotingname: firefox 05:39:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:39:43 INFO - mozversion application_vendor: Mozilla 05:39:43 INFO - mozversion application_version: 54.0 05:39:43 INFO - mozversion platform_buildid: 20170509041042 05:39:43 INFO - mozversion platform_changeset: ffb4bf982bebe22f9250869885fb1388dc4539c5 05:39:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:39:43 INFO - mozversion platform_version: 54.0 05:39:43 INFO - using testdate: 1494333583 05:39:43 INFO - actual date: 1494333583 05:39:43 INFO - starting webserver on 'localhost:49242' 05:39:43 INFO - SUITE-START | Running 2 tests 05:39:43 INFO - TEST-START | dromaeo_css 05:39:43 INFO - operating with platform_type : mac_ 05:39:43 INFO - Initialising browser for dromaeo_css test... 05:39:43 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpjOSwPc/profile http://localhost:49242/getInfo.html) 05:39:45 INFO - PROCESS | 1639 | __metrics Screen width/height:1600/1200 05:39:45 INFO - PROCESS | 1639 | colorDepth:24 05:39:45 INFO - PROCESS | 1639 | Browser inner width/height: 1024/689 05:39:45 INFO - PROCESS | 1639 | __metrics 05:39:45 INFO - PROCESS | 1639 | 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" 05:39:45 INFO - PROCESS | 1639 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:39:46 INFO - TEST-INFO | 1639: exit 0 05:39:46 INFO - Browser initialized. 05:39:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:39:46 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpjOSwPc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:39:58 INFO - PROCESS | 1642 | RSS: Main: 164962304 05:39:58 INFO - PROCESS | 1642 | 05:43:01 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 05:43:03 INFO - PROCESS | 1642 | RSS: Main: 293367808 05:43:03 INFO - PROCESS | 1642 | 05:46:06 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 05:46:07 INFO - PROCESS | 1642 | RSS: Main: 358088704 05:46:07 INFO - PROCESS | 1642 | 05:49:09 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 05:49:10 INFO - PROCESS | 1642 | RSS: Main: 269512704 05:49:10 INFO - PROCESS | 1642 | 05:52:12 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 05:52:13 INFO - PROCESS | 1642 | RSS: Main: 270880768 05:52:13 INFO - PROCESS | 1642 | 05:55:16 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 05:55:17 INFO - PROCESS | 1642 | RSS: Main: 269164544 05:55:17 INFO - PROCESS | 1642 | 05:58:20 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 05:58:20 INFO - PROCESS | 1642 | RSS: Main: 520511488 05:58:20 INFO - PROCESS | 1642 | 05:58:20 INFO - PROCESS | 1642 | __start_tp_report 05:58:20 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 05:58:20 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 05:58:20 INFO - PROCESS | 1642 | |i|pagename|runs| 05:58:20 INFO - PROCESS | 1642 | |0;dojo.html;3146.2134466383404;3560.5549306336693;3567.072561134105;3589.7307701922364;3603.675669189772;5941.494972927301;6047.123167140768;6116.327204007567;6131.110988906611;6144.293406258282;6035.698215089239;6101.725422355994;6113.266408031042;6119.510439164867;6127.938720612792;5468.28912241409;5491.945080549203;5503.6147469677135;5510.338759348884;5618.297712785902;4770.570648641621;5431.4840090191365;5432.945670543283;5466.125419932811;5621.971890140544;5492.395836457987;5540.501354878081;5548.889022219553;5549.916751248735;5555;5535.474129957647;5539.086050801653;5554.86112847178;5570.359408668014;5578.44215578443;5417.133258678632;5482.5888058395385;5495.148252020943;5498.395176530578;5529.612927095105;6106.175666285084;6128.479079278267;6129.325774164839;6172.07418887166;6186.319504854462;6398.744050237985;6415.166028416323;6431.163948686688;6455.193100862392;6472.417482426604;6594.340565943367;6630.73477060917;6649.900251496183;6662.367075127903;6667.533272670915;6219.937800621981;6221.377862213742;6226.097215903714;6233.283172435228;6247.156633854463;6503.447206987365;6532.771353002717;6809.659517024129;6823.795286141324;6830;6192.225971753531;6261.373862613702;6262.530310226751;6269.937300627026;6336.524760642878;6448.580842245333;6465.997770345604;6496.058071579594;6503.317151699098;6505.316941721146;5357.249985002103;6300.0234963580715;6400.519961002943;6410.583312084699;6411.0383442484;6402.103705481236;6462.773802916875;6514.348565143448;6579.374959378852;6603.570767900071;5346.7861285548925;5348.545373643284;5369.919451208235;5371.892562148813;5375.838724838261;3934.6852251819787;4728.787204575802;4741.57325840676;4758.405199350082;4766.809327626856;6116.51838140169;6151.077338399186;6156.168917196211;6228.159198508234;6244.406781355764;6630.9336906630315;6675.666216689243;6676.499262555328;6681.33186681328;6683.832904177434;5302.257683924254;6232.470240029557;6236.438720515084;6246.562740608205;6247.250329960434;5639.943600564024;5662.745176467069;5760.8271751847515;5775.960327141155;5898.174255604219;6670.232923213698;6686.531942764057;6705;6708.6981085850275;6719.664016799238;6492.902606460812;6498.122753428227;6553.836154096186;6575.934240657532;6678.198616166092;6802.659867006729;6861.519693621399;6862.176538815374;6875.4155896749335;6879.105716256855;6540.051692504465;6541.803745887631;6543.214814222324;6562.245341785565;6566;6387.297397286202;6410.839729006812;6536.182977127859;6540.444062254762;6613.735450582115;6462.612243265419;6482.902756458562;6483.351664833667;6488.935110649022;6490.707918143789;6460.386263305167;6461.741530338922;6473.126127972663;6491.221053473613;6495.220573531206;6109.969450152898;6159;6203.906941395973;6342.39747224013;6370.235571731422;6415.8716825662295;6452.161219041494;6479.838004049937;6481.222253329631;6523.8042858712415;6294.213223347082;6298.937010629835;6307.306196318493;6310.7475700971445;6316.968415157895 05:58:20 INFO - PROCESS | 1642 | |1;ext.html;806.9152738962409;844.522844592805;920.190232595316;931.5435436636042;1011.3173607814723;39251;40177.397339039904;41951;41973.7901310493;42093;40006.39990400146;40170;40180.79457616269;40221.59778402215;40640.59359406405;8095.919040809576;8235.629396677165;8333.333333333334;8463.026751923546;8463.576821158917;11793.233439826427;12003.399830008508;12258.957988570983;12274.754504909897;12289.385530723473;12056.57801976931;12072;12078.15452918296;12083.879161208364;12111.939440302785;12000.51997920082;12042.518299268018;12045.819312710317;12090.939545302304;12104.818427723547;11684;11746.647600571996;11748.765024699544;11750.353730544817;11763.882361176364;41494.547690830674;41495.37756933648;41523;41603.7919810399;41666;4022.3765316376007;4106.096658735073;4112.876613701594;4126.216018956418;4130.297849365585;28773;28810.135695928948;30927.536086958713;30986.915457958865;30998.38003239945;3306.057773534531;3310.9834450827834;3320.0537846713814;3444.8277586120594;3450.5341778859784;371383;377377.99999999726;377703;377782;378522;47406.5259347409;48237;48571;53948.73025634847;54374.45625543694;55858.44141558614;56664.15003774947;56690.86618267694;56756;56787;13400.32998350098;15861.603459913364;15896.920515397349;15909.045457272601;15918.602034948988;13555.390007449689;13604.251766152758;13607.863921360859;13624.04631675793;13658.863411365759;12392.75214495705;12398.5660501882;12427.254364738144;12474.126811123135;12536.74926501483;5752.309722833287;5762.078067509178;5779.739911703983;5801.622894511843;5803.593748437569;940.7789169545151;982.7002764156858;985.7880555680563;1013.7060252526832;1049.8425236214475;29396.559051614244;29601;29974.400511990076;30087.699123008926;30225.848870755504;1099.263493459384;1117;1132.247055707945;1135.1940122513108;1178.1458442629025;13459.022777883138;13617.97865160117;13658.795118073236;14223.92888035574;14397.64005899861;412532;413929;415634;415937;416646;42560.14879702389;46420.30369544459;49393.75303123461;49633.75183124061;49858.25212621813;1480.1563109027966;1498.7826765119214;1499.9027009225913;1521.8630323270959;1531.793207916917;27417.725822742315;28153.839272846802;28191.01331453389;28463.43073138567;28572.42855142927;41396.37905431481;41484.792576036925;41570.58429415667;41623.37564936468;41718.79140604399;426624;427965;428642;429017;430485;23609.347345686325;29788.851055744584;30056.549151763178;31117.68882311148;31135.37729245357;39141;39445.01387465336;39924.80037599793;39938;40415;27902.883884644387;28576;28581.28546786347;28642.427151457272;29419.705802942553;28234.71765282321;28539.28651783722;28628.997985070422;29140.417191656474;29329.706702933552;32423;33624.663753362154;33697.65209391597;43705;43965.34051989287;31145.37709245848;40213.798931005156;41652;42835.714928552195;43262.91842703832;27495.450090998467;33287.50068749019;33457;33776.91484330232;33803.3239335207 05:58:20 INFO - PROCESS | 1642 | |2;jquery.html;433.27642836463104;439.51653181500336;443.17569321062825;444.2470013327409;451.9163954668389;17906.64186716265;20320.796792032073;22423.103075876985;22702.88648556759;22835.657465138014;22734.863256837176;23183.652245216294;23657.881710591424;23660.881695591543;23945.281641550737;7012.579245245276;7122.7179107760585;7189.2451292614305;7393.445491588152;7405.407567394595;7167.749128780494;7292.781216563485;7294.525855819381;7304.5252058616015;7328.67020984057;6973.372396484316;7125.85748285034;7260.963695181543;7277.417806575461;7282.162551306615;7000.544964577337;7062.576245425291;7139.428845692358;7192.856142877165;7198.604076775775;7043.190033146203;7052.61210633415;7054.576725396441;7055.964720176417;7058.470614703918;26993.730062699316;27334.863325683244;27524.862375687993;27617.309567260778;27892.442151157065;2969.3505665863363;2970.2722832906074;3067.4325249828853;3141.952870706941;3195.744340452758;12437.751244975141;16449.342026318933;16500.92743971638;16977.405790797264;16985.660286794195;1927.209843963968;2069.596428696405;2104.715863358442;2130.776268491817;2133.9466513337134;118196;118692.40653796762;141099.29450352784;148158.51841481554;170307;19942.60114797725;20802.58394832125;20957.371278861658;20991.16035358599;21185;32531.67468325334;33136.3372732544;33294.50058249128;33296.3340733184;33333.499997500054;10636.840447393295;10769.730756730987;10952;10963.945180274048;11146.777064458665;9077.04691007448;9088.636454541744;9090.90909090914;9245;9248.398854074463;7899.210078992055;9466.337356385126;9602.66390676323;9635.807283854283;9825.361351512129;3476.4090104682264;3502.2470168913806;3772.490713753608;3928.7249892507252;4016.879493615196;988.7577543501744;1123.3652986063012;1124.4033472469114;1154.8036833738286;1168.1414160591958;20542.69185962212;21941.890290548763;23110.53778924412;23138.768612313663;23149;1044.603050840691;1106.1316866259947;1107.5403707461473;1117;1155.8844115588543;9740.512974351253;11710.70723231926;11792;11972.341521216242;12005;642930;654693.7265313643;693140;703763;734580;105789.47105264578;127682;145596;148124;153104.468955309;1227.742174143422;1233.6052463211865;1265.7595056939151;1268.2010333489843;1272.5864094169433;15029.473968411054;20746.792532074487;20927.927972790556;21222.681659775426;21253.6811947824;46514.53485465102;60398;62854.74290514072;63043.369566305584;65087.37281567809;82836;83789.90525236918;85122.72315915143;85222.72165917393;85385.14614853772;11062.612808551663;11275.04162146194;11576.594819181288;11795.941020295188;12010.75978480443;13044.282564459047;13159.934200328937;13281.66795830112;13493.662658433617;13509.797353039516;11396.886031139582;11530.135239856876;11588.188826782382;11927.4036298183;11936.045116390842;9200.447973121634;10262.846057308998;10324.845127322946;10679.679609611723;10766.784664306513;11146.832797508207;11608.593699220486;11635.47640356203;11871.228370155912;11925.880741192477;11578.884211157781;11636.243644163102;11762.58830940913;11877.406129693654;11973.521059157536;11223.158263130135;11376.544938202711;11566.190366674253;11644.72927779075;11664.475098620413 05:58:20 INFO - PROCESS | 1642 | |3;mootools.html;1625.081828766746;1639.5573195237287;1660.1035440861936;1662.2602941690952;1678.6223099802542;11032.50353734082;11739.354335511543;11744.882551174507;11753.177277590572;11754.471048802803;11038.11695064395;11314.37770922599;11321;11518.654440366803;11547.942260288708;2491.5266099441137;2528.962065569018;2533.9239822805343;2534.125726624321;2546.656201412804;2399.6520504526834;2429.501952099824;2432.1001229545095;2434.914777982771;2481.900723971039;2134.9146034158616;2483.987580062097;2500.2999160235163;2516.1570873757223;2523.3187039499326;2436.074291769134;2453.1168779239547;2462.4582591829767;2468.1361523466735;2510.397504598883;2448.571499987495;2474.5669507836055;2495.987520062406;2502.51201015802;2511.9246422607353;11478.713032174179;11565.190436669436;11567.479463424166;11578.53685852565;11641.6507504775;5978.461938425519;6158.230221222348;6161.599496032788;6194.4425001749605;6211.4409703126485;3675.687566556846;3777.886663400075;3791.9620803791886;3857.4406711026745;3868.5357757069332;1310.7706151423463;1905.7808352039553;1935.5644979879555;1957.4812674641232;1990.3630838131803;14332.785008224884;14646.633834154125;15061.849381506154;15251.694966100727;15398.461053863173;4196.559361267084;4475.932861007088;4504.909901801946;4581.518940511265;4962.627802914796;12128.393580320948;12150.756984860252;12154.392280386122;12188.207766495327;12231.816522752166;6104.542159338067;6113.449789518876;6114.510839132859;6124.816255512342;6128.3565225651555;5463.672179669233;5511.366192887789;5556.027695153332;5632.802851900164;5655.321361436571;4004.9989544988293;4081.510218773766;4121.5878412158545;4169.958300417018;4173.08192197716;1080.1790639114329;1081.1999120650662;1082.6373164989816;1098.5715570927346;1100;942.29328003997;967.3277072434731;970.8207260785052;971.5482300730054;972.5331840716495;6894.034835123087;7032.226455089936;7035.718571257093;7053.612051337123;7135.1437827459995;982.8771403574553;1013.1692012549638;1023.498485741996;1037.6316407675317;1070.1920050361928;4265.658747300208;4400.427944367212;4430.778461076933;4484.103179364075;4602.631789456836;13685.589432316847;14317.997740158296;14326.355314010894;14344.928275358556;14362;11612.245204061877;11998;13376;14077.788833167511;14105.224212668196;8822.823543529094;9103.635854565744;10201.795964080826;10478.842817357745;10526.263161578616;5583.525400341016;7159.355657990805;7362.263773622595;7394;7395.964564960802;10440;10563.63027294041;12065.215760975509;12265.38673066361;12284;11570.305781653127;12790.808137877753;12854.100212985002;12900.741985160432;13179;9314.44113353201;9561.665341713007;9576.186024188022;9584.66453674118;9585.137337639646;10402.947985260025;10535.209859260432;10537.946205379401;10639.521221544894;10686.25196236256;8979.506127162807;9090.318226133199;9150.771230719285;9156;9300.674476393293;8129.7967550809335;8864.468131912106;8869.06874778139;8935.195832375117;8938.553072346487;7927.454146441389;8341.833163336578;8344.66621335164;8354.289885359813;8354.540500272544;5294.258803767399;5918.23063001807;5931.9406805931385;6120.632762034292;6168.25980882297;6030.547708921761;6092.116643086816;6122.602030867979;6179.721912514037;6345.524085693499 05:58:20 INFO - PROCESS | 1642 | |4;prototype.html;388.7007004606453;391.74732297667987;393.55921368067766;400.85769551809113;401.50815251317124;4597.046255341479;5180.886553866436;5226.477352264772;5245.79016839326;5274.993253845305;4203.873883783492;4526.524714904937;4989.877277612535;5153.81961631343;5171.870703232421;4099.642705444381;4113.588641135892;4113.938290925638;4121.845883152722;4140.937885931706;3560.287942411515;4113.25961326961;4120.155368149537;4140.875773726778;4158.397032430295;3578.57057153142;3942.664873485757;4105.876823695279;4136.607981455208;4159.646430053449;3508.561429821272;3533.9646603533893;3604.7743767119305;4125.834966601333;4395.362672412514;3408.2222988264734;3512.2799826035603;3816.713746469026;4026.315526360526;4034.2536630723116;4184.2050010498215;4618.745968971705;4858.105338917825;5127.179851152824;5208.583313334924;4488.8877778055485;4594.151625991873;4875.6840500761855;5012.248162775576;5050.343455350818;4765.451228350766;5622;5634.6337488063555;5667.489925906688;5693.516051135658;3976.443297938291;4557.544245575449;4597.7011494252765;4620.059574978483;4637.536246375369;5488.890222195534;5683.886322273532;5807.548112971757;5903.2325797646035;5957.987142185795;3811.6378944000276;4145.461090058334;4665.486796452387;4686.554777296152;4748.934213617088;4787.558345243881;4819.3012013258585;4832.251001094836;4863.416390033219;4873.661541843849;4389.670774691911;4419.751482660242;4515.9774201128785;4684.742339171378;5061.44324124346;5507.779688812483;5509.721715579224;5527;5550.777968881281;5660.915086273709;1431.484665520412;1452.8256609206962;1453.9200343980972;1462.4881291547872;1596.9259176085989;995.716220877061;1132.4960392625203;1161.4134861894688;1207.9516819327305;1215.3046500132266;4849.830255941025;5279.498447647467;5303.942483999744;5305.62860599762;5337.185356978646;5076.568491678175;5720.827230417837;5733.620547472836;5814.883702325929;5830.737616807254;4622.699524530894;4634;5098.770555324945;5152.458991805806;5189.31347312125;2695.5148073346986;2837.5459926411677;3038.7844862055354;3052.9236769080508;3065.708757668018;4988.451270360258;5441.455854414606;5627.296587926509;5797.913031304533;5914.9704251479325;4735.082291671878;5895.263092113486;5922.009385260416;5959.821205363846;5975.133605627247;4937.975310123426;5062.7468626568525;5265.868353291198;5308.619758862724;5972.431090215901;5088.829569199179;5606.1408681571875;5743.8644176193075;5751.654900705971;5818.505427038749;4715.22198837188;5172.7068232941765;5811.883762324645;5818.9342783313;5820.76716931318;4783.679915241175;5229.633925625322;5317.909828485229;5359.365393554847;5769.451902069297;4284.151039558658;4456.952616135271;4727.163701779043;4739.099571081483;4741.454732705783;5410.810621628224;5697.7720891165545;5707.20099186106;5779.971100144472;5901.350851406256;5170.1727723564045;5321.685066995869;5555.30558680165;5556.472135147154;5567.081431563746;4775.665703400868;5270.657407268515;5500.559955203654;5623.803166889139;5675.779707362937;5413.215083812904;5466.671999680032;5482.205080263259;5485.588580856372;5496.422875598005;5551.528844856197;5569.220309156803;5569.693666848362;5611.494965453129;5611.775528978958;4796.8081276748535;5421.701806400686;5443.319585051869;5465.64977059868;5479.863003424787 05:58:20 INFO - PROCESS | 1642 | |5;yui.html;765.2500549461531;786.7993661616287;807.9636416361263;899.4468401932811;900.1616312321271;15555.533333999983;16672.58318542037;17194.3122275109;18108.366207182753;18308.633827323447;15538.689226215469;15759.133247671374;15771.369145234206;16308.673826523493;16836.410725624606;998.1104701888048;1024.196006135184;1025.3540269630123;1027.4297764740566;1030.876294844616;987.0474991633073;1001.8397056470966;1030.8814486334093;1034.9120324772366;1039.6932904793105;1047.0942634621074;1047.2198212331823;1047.8794938582084;1048.4024106259435;1048.6696690542492;1032.9070383665505;1035.7514196592763;1035.9067683908447;1037.1495373793493;1039.77644806367;772.5982489105689;772.8067983004249;773.4585789947059;774.040190164198;776.0144616337277;17411.825881741148;17498.037607931557;17500.474985750447;18209.99845008524;18428.723569146474;14744.557663270012;14977.326020329112;15069.246537673182;15143.924280378527;15337.539873803804;11893.40532973348;12083.758324833454;12347.320897350643;12538.749225015448;12643.936780316131;3755.9436608450897;3796.3356412627954;3959.0894094358173;3994.460747799039;4080.2451546463703;110433.44783276113;115413.845861542;118142.40928795387;119938.40030799877;122251;11402.543898243977;11500.25248358854;11582.594609188638;11749;11770.764584708259;24106.638400424006;24186.395340116287;24447.777611119374;24568.385790355384;24602.384940376276;7910.802229944183;8037.115917249098;8063.717769878026;8127.552984585905;8245.8350832983;4629.282461218517;4629.398178236807;4673.345731597579;4674.5325467452985;4754.500777418321;3614.963850361463;3672.467492213614;3685.355062863988;3707.2029513654693;3715.21980384117;638.8498702804837;639.5139693832721;642.3672682407824;655.7606473637088;663.3002182697204;613.6992873491956;705.6930235347537;733.3509843788286;735.9632018399059;766.4941138848334;10615.628453004263;10823.67528974132;11095.72260693489;11160.497777600027;11307.434628268718;696.7805141380449;733.3986131372224;743.8140464883779;755.9659815308324;761.919998400171;4911.45973942866;5140.331756871583;5262.105442074857;5274.208868669653;5282.81510147143;106020;108469.91530084756;109371.90628093776;109684;109990.45004775086;54353.72823135938;60833.391666082774;77475;84429.31141377261;86960;78347;78373.8243926353;80134.79797803154;80753.59623201846;81147.7827832583;9793.314467987457;10839.512221950188;11014.118870490502;11327.207095503236;11407.37259450705;48334.516654833;52218;52629.94740105253;53258;53571.7321413406;54773.45226547684;66879.32801679998;67170.66414668091;68189.65905170442;68952;13165.802512962506;13230.801537977131;13493.190408575518;13692.52076177329;14008.949328800585;15126;15487.606115449664;15647.530574082795;15737.68524629524;15765.448209313077;11700.765984680429;14043.929780351442;14229.359678814271;14587.781183282046;14590.416383344547;11948.430171222475;11970.802919708309;11972.700682483008;12197.32914689665;12372.876271237172;11995.940020299842;12072.818907716215;12282.078844086907;12577.371131443208;12642.87357126417;8890.86663700058;9029.051949545203;9250.907490925005;9373.625054997996;9672.903270967201;8542.487450752975;9426.434413935185;9903.762029746282;10490.52792624349;10813.513391897226 05:58:20 INFO - PROCESS | 1642 | __end_tp_report 05:58:20 INFO - PROCESS | 1642 | __start_cc_report 05:58:20 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1735 05:58:20 INFO - PROCESS | 1642 | __end_cc_report 05:58:20 INFO - PROCESS | 1642 | __startTimestamp1494334700507__endTimestamp 05:58:20 INFO - PROCESS | 1642 | 05:58:20 INFO - PROCESS | 1642 | ------- Summary: start ------- 05:58:20 INFO - PROCESS | 1642 | Number of tests: 6 05:58:20 INFO - PROCESS | 1642 | 05:58:20 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:6073.57 Median:6269.94 stddev:691.88 (11.0%) stddev-sans-first:654.79 05:58:20 INFO - PROCESS | 1642 | Values: 3146.2 3560.6 3567.1 3589.7 3603.7 5941.5 6047.1 6116.3 6131.1 6144.3 6035.7 6101.7 6113.3 6119.5 6127.9 5468.3 5491.9 5503.6 5510.3 5618.3 4770.6 5431.5 5432.9 5466.1 5622.0 5492.4 5540.5 5548.9 5549.9 5555.0 5535.5 5539.1 5554.9 5570.4 5578.4 5417.1 5482.6 5495.1 5498.4 5529.6 6106.2 6128.5 6129.3 6172.1 6186.3 6398.7 6415.2 6431.2 6455.2 6472.4 6594.3 6630.7 6649.9 6662.4 6667.5 6219.9 6221.4 6226.1 6233.3 6247.2 6503.4 6532.8 6809.7 6823.8 6830.0 6192.2 6261.4 6262.5 6269.9 6336.5 6448.6 6466.0 6496.1 6503.3 6505.3 5357.2 6300.0 6400.5 6410.6 6411.0 6402.1 6462.8 6514.3 6579.4 6603.6 5346.8 5348.5 5369.9 5371.9 5375.8 3934.7 4728.8 4741.6 4758.4 4766.8 6116.5 6151.1 6156.2 6228.2 6244.4 6630.9 6675.7 6676.5 6681.3 6683.8 5302.3 6232.5 6236.4 6246.6 6247.3 5639.9 5662.7 5760.8 5776.0 5898.2 6670.2 6686.5 6705.0 6708.7 6719.7 6492.9 6498.1 6553.8 6575.9 6678.2 6802.7 6861.5 6862.2 6875.4 6879.1 6540.1 6541.8 6543.2 6562.2 6566.0 6387.3 6410.8 6536.2 6540.4 6613.7 6462.6 6482.9 6483.4 6488.9 6490.7 6460.4 6461.7 6473.1 6491.2 6495.2 6110.0 6159.0 6203.9 6342.4 6370.2 6415.9 6452.2 6479.8 6481.2 6523.8 6294.2 6298.9 6307.3 6310.7 6317.0 05:58:20 INFO - PROCESS | 1642 | 05:58:20 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:55351.12 Median:33540.83 stddev:107586.25 (320.8%) stddev-sans-first:107810.11 05:58:20 INFO - PROCESS | 1642 | Values: 806.9 844.5 920.2 931.5 1011.3 39251.0 40177.4 41951.0 41973.8 42093.0 40006.4 40170.0 40180.8 40221.6 40640.6 8095.9 8235.6 8333.3 8463.0 8463.6 11793.2 12003.4 12259.0 12274.8 12289.4 12056.6 12072.0 12078.2 12083.9 12111.9 12000.5 12042.5 12045.8 12090.9 12104.8 11684.0 11746.6 11748.8 11750.4 11763.9 41494.5 41495.4 41523.0 41603.8 41666.0 4022.4 4106.1 4112.9 4126.2 4130.3 28773.0 28810.1 30927.5 30986.9 30998.4 3306.1 3311.0 3320.1 3444.8 3450.5 371383.0 377378.0 377703.0 377782.0 378522.0 47406.5 48237.0 48571.0 53948.7 54374.5 55858.4 56664.2 56690.9 56756.0 56787.0 13400.3 15861.6 15896.9 15909.0 15918.6 13555.4 13604.3 13607.9 13624.0 13658.9 12392.8 12398.6 12427.3 12474.1 12536.7 5752.3 5762.1 5779.7 5801.6 5803.6 940.8 982.7 985.8 1013.7 1049.8 29396.6 29601.0 29974.4 30087.7 30225.8 1099.3 1117.0 1132.2 1135.2 1178.1 13459.0 13618.0 13658.8 14223.9 14397.6 412532.0 413929.0 415634.0 415937.0 416646.0 42560.1 46420.3 49393.8 49633.8 49858.3 1480.2 1498.8 1499.9 1521.9 1531.8 27417.7 28153.8 28191.0 28463.4 28572.4 41396.4 41484.8 41570.6 41623.4 41718.8 426624.0 427965.0 428642.0 429017.0 430485.0 23609.3 29788.9 30056.5 31117.7 31135.4 39141.0 39445.0 39924.8 39938.0 40415.0 27902.9 28576.0 28581.3 28642.4 29419.7 28234.7 28539.3 28629.0 29140.4 29329.7 32423.0 33624.7 33697.7 43705.0 43965.3 31145.4 40213.8 41652.0 42835.7 43262.9 27495.5 33287.5 33457.0 33776.9 33803.3 05:58:20 INFO - PROCESS | 1642 | 05:58:20 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:40567.69 Median:22182.50 stddev:114293.89 (515.2%) stddev-sans-first:114574.79 05:58:20 INFO - PROCESS | 1642 | Values: 433.3 439.5 443.2 444.2 451.9 17906.6 20320.8 22423.1 22702.9 22835.7 22734.9 23183.7 23657.9 23660.9 23945.3 7012.6 7122.7 7189.2 7393.4 7405.4 7167.7 7292.8 7294.5 7304.5 7328.7 6973.4 7125.9 7261.0 7277.4 7282.2 7000.5 7062.6 7139.4 7192.9 7198.6 7043.2 7052.6 7054.6 7056.0 7058.5 26993.7 27334.9 27524.9 27617.3 27892.4 2969.4 2970.3 3067.4 3142.0 3195.7 12437.8 16449.3 16500.9 16977.4 16985.7 1927.2 2069.6 2104.7 2130.8 2133.9 118196.0 118692.4 141099.3 148158.5 170307.0 19942.6 20802.6 20957.4 20991.2 21185.0 32531.7 33136.3 33294.5 33296.3 33333.5 10636.8 10769.7 10952.0 10963.9 11146.8 9077.0 9088.6 9090.9 9245.0 9248.4 7899.2 9466.3 9602.7 9635.8 9825.4 3476.4 3502.2 3772.5 3928.7 4016.9 988.8 1123.4 1124.4 1154.8 1168.1 20542.7 21941.9 23110.5 23138.8 23149.0 1044.6 1106.1 1107.5 1117.0 1155.9 9740.5 11710.7 11792.0 11972.3 12005.0 642930.0 654693.7 693140.0 703763.0 734580.0 105789.5 127682.0 145596.0 148124.0 153104.5 1227.7 1233.6 1265.8 1268.2 1272.6 15029.5 20746.8 20927.9 21222.7 21253.7 46514.5 60398.0 62854.7 63043.4 65087.4 82836.0 83789.9 85122.7 85222.7 85385.1 11062.6 11275.0 11576.6 11795.9 12010.8 13044.3 13159.9 13281.7 13493.7 13509.8 11396.9 11530.1 11588.2 11927.4 11936.0 9200.4 10262.8 10324.8 10679.7 10766.8 11146.8 11608.6 11635.5 11871.2 11925.9 11578.9 11636.2 11762.6 11877.4 11973.5 11223.2 11376.5 11566.2 11644.7 11664.5 05:58:20 INFO - PROCESS | 1642 | 05:58:20 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6910.21 Median:2514.04 stddev:4206.01 (167.3%) stddev-sans-first:4199.06 05:58:20 INFO - PROCESS | 1642 | Values: 1625.1 1639.6 1660.1 1662.3 1678.6 11032.5 11739.4 11744.9 11753.2 11754.5 11038.1 11314.4 11321.0 11518.7 11547.9 2491.5 2529.0 2533.9 2534.1 2546.7 2399.7 2429.5 2432.1 2434.9 2481.9 2134.9 2484.0 2500.3 2516.2 2523.3 2436.1 2453.1 2462.5 2468.1 2510.4 2448.6 2474.6 2496.0 2502.5 2511.9 11478.7 11565.2 11567.5 11578.5 11641.7 5978.5 6158.2 6161.6 6194.4 6211.4 3675.7 3777.9 3792.0 3857.4 3868.5 1310.8 1905.8 1935.6 1957.5 1990.4 14332.8 14646.6 15061.8 15251.7 15398.5 4196.6 4475.9 4504.9 4581.5 4962.6 12128.4 12150.8 12154.4 12188.2 12231.8 6104.5 6113.4 6114.5 6124.8 6128.4 5463.7 5511.4 5556.0 5632.8 5655.3 4005.0 4081.5 4121.6 4170.0 4173.1 1080.2 1081.2 1082.6 1098.6 1100.0 942.3 967.3 970.8 971.5 972.5 6894.0 7032.2 7035.7 7053.6 7135.1 982.9 1013.2 1023.5 1037.6 1070.2 4265.7 4400.4 4430.8 4484.1 4602.6 13685.6 14318.0 14326.4 14344.9 14362.0 11612.2 11998.0 13376.0 14077.8 14105.2 8822.8 9103.6 10201.8 10478.8 10526.3 5583.5 7159.4 7362.3 7394.0 7396.0 10440.0 10563.6 12065.2 12265.4 12284.0 11570.3 12790.8 12854.1 12900.7 13179.0 9314.4 9561.7 9576.2 9584.7 9585.1 10402.9 10535.2 10537.9 10639.5 10686.3 8979.5 9090.3 9150.8 9156.0 9300.7 8129.8 8864.5 8869.1 8935.2 8938.6 7927.5 8341.8 8344.7 8354.3 8354.5 5294.3 5918.2 5931.9 6120.6 6168.3 6030.5 6092.1 6122.6 6179.7 6345.5 05:58:20 INFO - PROCESS | 1642 | 05:58:20 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4625.04 Median:5055.89 stddev:1310.32 (25.9%) stddev-sans-first:1274.83 05:58:20 INFO - PROCESS | 1642 | Values: 388.7 391.7 393.6 400.9 401.5 4597.0 5180.9 5226.5 5245.8 5275.0 4203.9 4526.5 4989.9 5153.8 5171.9 4099.6 4113.6 4113.9 4121.8 4140.9 3560.3 4113.3 4120.2 4140.9 4158.4 3578.6 3942.7 4105.9 4136.6 4159.6 3508.6 3534.0 3604.8 4125.8 4395.4 3408.2 3512.3 3816.7 4026.3 4034.3 4184.2 4618.7 4858.1 5127.2 5208.6 4488.9 4594.2 4875.7 5012.2 5050.3 4765.5 5622.0 5634.6 5667.5 5693.5 3976.4 4557.5 4597.7 4620.1 4637.5 5488.9 5683.9 5807.5 5903.2 5958.0 3811.6 4145.5 4665.5 4686.6 4748.9 4787.6 4819.3 4832.3 4863.4 4873.7 4389.7 4419.8 4516.0 4684.7 5061.4 5507.8 5509.7 5527.0 5550.8 5660.9 1431.5 1452.8 1453.9 1462.5 1596.9 995.7 1132.5 1161.4 1208.0 1215.3 4849.8 5279.5 5303.9 5305.6 5337.2 5076.6 5720.8 5733.6 5814.9 5830.7 4622.7 4634.0 5098.8 5152.5 5189.3 2695.5 2837.5 3038.8 3052.9 3065.7 4988.5 5441.5 5627.3 5797.9 5915.0 4735.1 5895.3 5922.0 5959.8 5975.1 4938.0 5062.7 5265.9 5308.6 5972.4 5088.8 5606.1 5743.9 5751.7 5818.5 4715.2 5172.7 5811.9 5818.9 5820.8 4783.7 5229.6 5317.9 5359.4 5769.5 4284.2 4457.0 4727.2 4739.1 4741.5 5410.8 5697.8 5707.2 5780.0 5901.4 5170.2 5321.7 5555.3 5556.5 5567.1 4775.7 5270.7 5500.6 5623.8 5675.8 5413.2 5466.7 5482.2 5485.6 5496.4 5551.5 5569.2 5569.7 5611.5 5611.8 4796.8 5421.7 5443.3 5465.6 5479.9 05:58:20 INFO - PROCESS | 1642 | 05:58:20 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:20879.75 Median:18159.18 stddev:29975.71 (165.1%) stddev-sans-first:30021.76 05:58:20 INFO - PROCESS | 1642 | Values: 765.3 786.8 808.0 899.4 900.2 15555.5 16672.6 17194.3 18108.4 18308.6 15538.7 15759.1 15771.4 16308.7 16836.4 998.1 1024.2 1025.4 1027.4 1030.9 987.0 1001.8 1030.9 1034.9 1039.7 1047.1 1047.2 1047.9 1048.4 1048.7 1032.9 1035.8 1035.9 1037.1 1039.8 772.6 772.8 773.5 774.0 776.0 17411.8 17498.0 17500.5 18210.0 18428.7 14744.6 14977.3 15069.2 15143.9 15337.5 11893.4 12083.8 12347.3 12538.7 12643.9 3755.9 3796.3 3959.1 3994.5 4080.2 110433.4 115413.8 118142.4 119938.4 122251.0 11402.5 11500.3 11582.6 11749.0 11770.8 24106.6 24186.4 24447.8 24568.4 24602.4 7910.8 8037.1 8063.7 8127.6 8245.8 4629.3 4629.4 4673.3 4674.5 4754.5 3615.0 3672.5 3685.4 3707.2 3715.2 638.8 639.5 642.4 655.8 663.3 613.7 705.7 733.4 736.0 766.5 10615.6 10823.7 11095.7 11160.5 11307.4 696.8 733.4 743.8 756.0 761.9 4911.5 5140.3 5262.1 5274.2 5282.8 106020.0 108469.9 109371.9 109684.0 109990.5 54353.7 60833.4 77475.0 84429.3 86960.0 78347.0 78373.8 80134.8 80753.6 81147.8 9793.3 10839.5 11014.1 11327.2 11407.4 48334.5 52218.0 52629.9 53258.0 53571.7 54773.5 66879.3 67170.7 68189.7 68952.0 13165.8 13230.8 13493.2 13692.5 14008.9 15126.0 15487.6 15647.5 15737.7 15765.4 11700.8 14043.9 14229.4 14587.8 14590.4 11948.4 11970.8 11972.7 12197.3 12372.9 11995.9 12072.8 12282.1 12577.4 12642.9 8890.9 9029.1 9250.9 9373.6 9672.9 8542.5 9426.4 9903.8 10490.5 10813.5 05:58:20 INFO - PROCESS | 1642 | -------- Summary: end -------- 05:58:20 INFO - PROCESS | 1642 | 05:58:21 INFO - TEST-INFO | 1642: exit 0 05:58:21 INFO - TEST-OK | dromaeo_css | took 1118031ms 05:58:21 INFO - TEST-START | kraken 05:58:21 INFO - operating with platform_type : mac_ 05:58:21 INFO - Initialising browser for kraken test... 05:58:21 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpDa8482/profile http://localhost:49242/getInfo.html) 05:58:23 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 05:58:23 INFO - PROCESS | 1652 | colorDepth:24 05:58:23 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 05:58:23 INFO - PROCESS | 1652 | __metrics 05:58:23 INFO - PROCESS | 1652 | 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" 05:58:23 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:58:24 INFO - TEST-INFO | 1652: exit 0 05:58:24 INFO - Browser initialized. 05:58:24 INFO - Running cycle 1/1 for kraken test... 05:58:24 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/T/tmpDa8482/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:58:36 INFO - PROCESS | 1654 | RSS: Main: 165126144 05:58:36 INFO - PROCESS | 1654 | 05:58:39 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 05:58:40 INFO - PROCESS | 1654 | RSS: Main: 216375296 05:58:40 INFO - PROCESS | 1654 | 05:58:42 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 05:58:43 INFO - PROCESS | 1654 | RSS: Main: 231411712 05:58:43 INFO - PROCESS | 1654 | 05:58:46 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 05:58:47 INFO - PROCESS | 1654 | RSS: Main: 326578176 05:58:47 INFO - PROCESS | 1654 | 05:58:49 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 05:58:49 INFO - PROCESS | 1654 | RSS: Main: 230526976 05:58:49 INFO - PROCESS | 1654 | 05:58:51 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:58:52 INFO - PROCESS | 1654 | RSS: Main: 231956480 05:58:52 INFO - PROCESS | 1654 | 05:58:55 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 05:58:55 INFO - PROCESS | 1654 | RSS: Main: 269987840 05:58:55 INFO - PROCESS | 1654 | 05:58:58 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 05:58:59 INFO - PROCESS | 1654 | RSS: Main: 271818752 05:58:59 INFO - PROCESS | 1654 | 05:59:02 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 05:59:02 INFO - PROCESS | 1654 | RSS: Main: 269787136 05:59:02 INFO - PROCESS | 1654 | 05:59:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:59:05 INFO - PROCESS | 1654 | RSS: Main: 247721984 05:59:05 INFO - PROCESS | 1654 | 05:59:06 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:59:07 INFO - PROCESS | 1654 | RSS: Main: 251396096 05:59:07 INFO - PROCESS | 1654 | 05:59:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:59:10 INFO - PROCESS | 1654 | RSS: Main: 257417216 05:59:10 INFO - PROCESS | 1654 | 05:59:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:59:13 INFO - PROCESS | 1654 | RSS: Main: 274149376 05:59:13 INFO - PROCESS | 1654 | 05:59:16 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:59:17 INFO - PROCESS | 1654 | RSS: Main: 267231232 05:59:17 INFO - PROCESS | 1654 | 05:59:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 05:59:19 INFO - PROCESS | 1654 | RSS: Main: 311599104 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | __start_tp_report 05:59:19 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 05:59:19 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 05:59:19 INFO - PROCESS | 1654 | |i|pagename|runs| 05:59:19 INFO - PROCESS | 1654 | |0;ai-astar;106;115;165;168;116;115;93;120;168;169 05:59:19 INFO - PROCESS | 1654 | |1;audio-beat-detection;137;108;105;134;109;108;107;104;125;107 05:59:19 INFO - PROCESS | 1654 | |2;audio-dft;182;181;182;186;182;185;184;183;185;184 05:59:19 INFO - PROCESS | 1654 | |3;audio-fft;82;59;58;88;60;61;71;80;94;57 05:59:19 INFO - PROCESS | 1654 | |4;audio-oscillator;89;69;85;68;68;68;80;68;68;81 05:59:19 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;89;88;90;88;88;88;90;89;88;88 05:59:19 INFO - PROCESS | 1654 | |6;imaging-darkroom;93;94;95;95;94;95;96;95;97;92 05:59:19 INFO - PROCESS | 1654 | |7;imaging-desaturate;90;83;84;84;98;128;106;85;85;84 05:59:19 INFO - PROCESS | 1654 | |8;json-parse-financial;60;59;59;60;62;62;63;63;63;63 05:59:19 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;61;56;55;63;59;57;58;57;58;57 05:59:19 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;85;80;80;80;80;80;83;82;81;87 05:59:19 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;136;143;138;134;134;134;134;135;198;168 05:59:19 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;161;160;160;162;161;165;159;164;161;161 05:59:19 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;64;64;65;64;64;63;63;63;63;62 05:59:19 INFO - PROCESS | 1654 | __end_tp_report 05:59:19 INFO - PROCESS | 1654 | __start_cc_report 05:59:19 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2058 05:59:19 INFO - PROCESS | 1654 | __end_cc_report 05:59:19 INFO - PROCESS | 1654 | __startTimestamp1494334759180__endTimestamp 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | ------- Summary: start ------- 05:59:19 INFO - PROCESS | 1654 | Number of tests: 14 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:133.50 Median:166.50 stddev:30.19 (18.1%) stddev-sans-first:30.34 05:59:19 INFO - PROCESS | 1654 | Values: 106.0 115.0 165.0 168.0 116.0 115.0 93.0 120.0 168.0 169.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:114.40 Median:108.50 stddev:12.58 (11.6%) stddev-sans-first:10.35 05:59:19 INFO - PROCESS | 1654 | Values: 137.0 108.0 105.0 134.0 109.0 108.0 107.0 104.0 125.0 107.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.65 (0.9%) stddev-sans-first:1.67 05:59:19 INFO - PROCESS | 1654 | Values: 182.0 181.0 182.0 186.0 182.0 185.0 184.0 183.0 185.0 184.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:71.00 Median:75.50 stddev:13.94 (18.5%) stddev-sans-first:14.21 05:59:19 INFO - PROCESS | 1654 | Values: 82.0 59.0 58.0 88.0 60.0 61.0 71.0 80.0 94.0 57.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:74.40 Median:74.50 stddev:8.40 (11.3%) stddev-sans-first:7.05 05:59:19 INFO - PROCESS | 1654 | Values: 89.0 69.0 85.0 68.0 68.0 68.0 80.0 68.0 68.0 81.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:88.60 Median:88.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 05:59:19 INFO - PROCESS | 1654 | Values: 89.0 88.0 90.0 88.0 88.0 88.0 90.0 89.0 88.0 88.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:1.43 (1.5%) stddev-sans-first:1.39 05:59:19 INFO - PROCESS | 1654 | Values: 93.0 94.0 95.0 95.0 94.0 95.0 96.0 95.0 97.0 92.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:92.70 Median:84.50 stddev:14.52 (17.2%) stddev-sans-first:15.37 05:59:19 INFO - PROCESS | 1654 | Values: 90.0 83.0 84.0 84.0 98.0 128.0 106.0 85.0 85.0 84.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:61.40 Median:62.50 stddev:1.71 (2.7%) stddev-sans-first:1.74 05:59:19 INFO - PROCESS | 1654 | Values: 60.0 59.0 59.0 60.0 62.0 62.0 63.0 63.0 63.0 63.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.00 stddev:2.38 (4.1%) stddev-sans-first:2.28 05:59:19 INFO - PROCESS | 1654 | Values: 61.0 56.0 55.0 63.0 59.0 57.0 58.0 57.0 58.0 57.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.50 stddev:2.49 (3.0%) stddev-sans-first:2.35 05:59:19 INFO - PROCESS | 1654 | Values: 85.0 80.0 80.0 80.0 80.0 80.0 83.0 82.0 81.0 87.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:137.00 stddev:21.22 (15.5%) stddev-sans-first:22.24 05:59:19 INFO - PROCESS | 1654 | Values: 136.0 143.0 138.0 134.0 134.0 134.0 134.0 135.0 198.0 168.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.40 Median:161.00 stddev:1.84 (1.1%) stddev-sans-first:1.94 05:59:19 INFO - PROCESS | 1654 | Values: 161.0 160.0 160.0 162.0 161.0 165.0 159.0 164.0 161.0 161.0 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.50 Median:64.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 05:59:19 INFO - PROCESS | 1654 | Values: 64.0 64.0 65.0 64.0 64.0 63.0 63.0 63.0 63.0 62.0 05:59:19 INFO - PROCESS | 1654 | -------- Summary: end -------- 05:59:19 INFO - PROCESS | 1654 | 05:59:19 INFO - TEST-INFO | 1654: exit 0 05:59:20 INFO - TEST-OK | kraken | took 58889ms 05:59:20 INFO - SUITE-END | took 1176s 05:59:20 INFO - Completed test suite (00:19:37) 05:59:20 INFO - javascript benchmark 05:59:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7928.901767454982, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3146.2134466383404, 3560.5549306336693, 3567.072561134105, 3589.7307701922364, 3603.675669189772, 5941.494972927301, 6047.123167140768, 6116.327204007567, 6131.110988906611, 6144.293406258282, 6035.698215089239, 6101.725422355994, 6113.266408031042, 6119.510439164867, 6127.938720612792, 5468.28912241409, 5491.945080549203, 5503.6147469677135, 5510.338759348884, 5618.297712785902, 4770.570648641621, 5431.4840090191365, 5432.945670543283, 5466.125419932811, 5621.971890140544, 5492.395836457987, 5540.501354878081, 5548.889022219553, 5549.916751248735, 5555.0, 5535.474129957647, 5539.086050801653, 5554.86112847178, 5570.359408668014, 5578.44215578443, 5417.133258678632, 5482.5888058395385, 5495.148252020943, 5498.395176530578, 5529.612927095105, 6106.175666285084, 6128.479079278267, 6129.325774164839, 6172.07418887166, 6186.319504854462, 6398.744050237985, 6415.166028416323, 6431.163948686688, 6455.193100862392, 6472.417482426604, 6594.340565943367, 6630.73477060917, 6649.900251496183, 6662.367075127903, 6667.533272670915, 6219.937800621981, 6221.377862213742, 6226.097215903714, 6233.283172435228, 6247.156633854463, 6503.447206987365, 6532.771353002717, 6809.659517024129, 6823.795286141324, 6830.0, 6192.225971753531, 6261.373862613702, 6262.530310226751, 6269.937300627026, 6336.524760642878, 6448.580842245333, 6465.997770345604, 6496.058071579594, 6503.317151699098, 6505.316941721146, 5357.249985002103, 6300.0234963580715, 6400.519961002943, 6410.583312084699, 6411.0383442484, 6402.103705481236, 6462.773802916875, 6514.348565143448, 6579.374959378852, 6603.570767900071, 5346.7861285548925, 5348.545373643284, 5369.919451208235, 5371.892562148813, 5375.838724838261, 3934.6852251819787, 4728.787204575802, 4741.57325840676, 4758.405199350082, 4766.809327626856, 6116.51838140169, 6151.077338399186, 6156.168917196211, 6228.159198508234, 6244.406781355764, 6630.9336906630315, 6675.666216689243, 6676.499262555328, 6681.33186681328, 6683.832904177434, 5302.257683924254, 6232.470240029557, 6236.438720515084, 6246.562740608205, 6247.250329960434, 5639.943600564024, 5662.745176467069, 5760.8271751847515, 5775.960327141155, 5898.174255604219, 6670.232923213698, 6686.531942764057, 6705.0, 6708.6981085850275, 6719.664016799238, 6492.902606460812, 6498.122753428227, 6553.836154096186, 6575.934240657532, 6678.198616166092, 6802.659867006729, 6861.519693621399, 6862.176538815374, 6875.4155896749335, 6879.105716256855, 6540.051692504465, 6541.803745887631, 6543.214814222324, 6562.245341785565, 6566.0, 6387.297397286202, 6410.839729006812, 6536.182977127859, 6540.444062254762, 6613.735450582115, 6462.612243265419, 6482.902756458562, 6483.351664833667, 6488.935110649022, 6490.707918143789, 6460.386263305167, 6461.741530338922, 6473.126127972663, 6491.221053473613, 6495.220573531206, 6109.969450152898, 6159.0, 6203.906941395973, 6342.39747224013, 6370.235571731422, 6415.8716825662295, 6452.161219041494, 6479.838004049937, 6481.222253329631, 6523.8042858712415, 6294.213223347082, 6298.937010629835, 6307.306196318493, 6310.7475700971445, 6316.968415157895], "value": 6028.114214894464, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.9152738962409, 844.522844592805, 920.190232595316, 931.5435436636042, 1011.3173607814723, 39251.0, 40177.397339039904, 41951.0, 41973.7901310493, 42093.0, 40006.39990400146, 40170.0, 40180.79457616269, 40221.59778402215, 40640.59359406405, 8095.919040809576, 8235.629396677165, 8333.333333333334, 8463.026751923546, 8463.576821158917, 11793.233439826427, 12003.399830008508, 12258.957988570983, 12274.754504909897, 12289.385530723473, 12056.57801976931, 12072.0, 12078.15452918296, 12083.879161208364, 12111.939440302785, 12000.51997920082, 12042.518299268018, 12045.819312710317, 12090.939545302304, 12104.818427723547, 11684.0, 11746.647600571996, 11748.765024699544, 11750.353730544817, 11763.882361176364, 41494.547690830674, 41495.37756933648, 41523.0, 41603.7919810399, 41666.0, 4022.3765316376007, 4106.096658735073, 4112.876613701594, 4126.216018956418, 4130.297849365585, 28773.0, 28810.135695928948, 30927.536086958713, 30986.915457958865, 30998.38003239945, 3306.057773534531, 3310.9834450827834, 3320.0537846713814, 3444.8277586120594, 3450.5341778859784, 371383.0, 377377.99999999726, 377703.0, 377782.0, 378522.0, 47406.5259347409, 48237.0, 48571.0, 53948.73025634847, 54374.45625543694, 55858.44141558614, 56664.15003774947, 56690.86618267694, 56756.0, 56787.0, 13400.32998350098, 15861.603459913364, 15896.920515397349, 15909.045457272601, 15918.602034948988, 13555.390007449689, 13604.251766152758, 13607.863921360859, 13624.04631675793, 13658.863411365759, 12392.75214495705, 12398.5660501882, 12427.254364738144, 12474.126811123135, 12536.74926501483, 5752.309722833287, 5762.078067509178, 5779.739911703983, 5801.622894511843, 5803.593748437569, 940.7789169545151, 982.7002764156858, 985.7880555680563, 1013.7060252526832, 1049.8425236214475, 29396.559051614244, 29601.0, 29974.400511990076, 30087.699123008926, 30225.848870755504, 1099.263493459384, 1117.0, 1132.247055707945, 1135.1940122513108, 1178.1458442629025, 13459.022777883138, 13617.97865160117, 13658.795118073236, 14223.92888035574, 14397.64005899861, 412532.0, 413929.0, 415634.0, 415937.0, 416646.0, 42560.14879702389, 46420.30369544459, 49393.75303123461, 49633.75183124061, 49858.25212621813, 1480.1563109027966, 1498.7826765119214, 1499.9027009225913, 1521.8630323270959, 1531.793207916917, 27417.725822742315, 28153.839272846802, 28191.01331453389, 28463.43073138567, 28572.42855142927, 41396.37905431481, 41484.792576036925, 41570.58429415667, 41623.37564936468, 41718.79140604399, 426624.0, 427965.0, 428642.0, 429017.0, 430485.0, 23609.347345686325, 29788.851055744584, 30056.549151763178, 31117.68882311148, 31135.37729245357, 39141.0, 39445.01387465336, 39924.80037599793, 39938.0, 40415.0, 27902.883884644387, 28576.0, 28581.28546786347, 28642.427151457272, 29419.705802942553, 28234.71765282321, 28539.28651783722, 28628.997985070422, 29140.417191656474, 29329.706702933552, 32423.0, 33624.663753362154, 33697.65209391597, 43705.0, 43965.34051989287, 31145.37709245848, 40213.798931005156, 41652.0, 42835.714928552195, 43262.91842703832, 27495.450090998467, 33287.50068749019, 33457.0, 33776.91484330232, 33803.3239335207], "value": 19405.824683420313, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [433.27642836463104, 439.51653181500336, 443.17569321062825, 444.2470013327409, 451.9163954668389, 17906.64186716265, 20320.796792032073, 22423.103075876985, 22702.88648556759, 22835.657465138014, 22734.863256837176, 23183.652245216294, 23657.881710591424, 23660.881695591543, 23945.281641550737, 7012.579245245276, 7122.7179107760585, 7189.2451292614305, 7393.445491588152, 7405.407567394595, 7167.749128780494, 7292.781216563485, 7294.525855819381, 7304.5252058616015, 7328.67020984057, 6973.372396484316, 7125.85748285034, 7260.963695181543, 7277.417806575461, 7282.162551306615, 7000.544964577337, 7062.576245425291, 7139.428845692358, 7192.856142877165, 7198.604076775775, 7043.190033146203, 7052.61210633415, 7054.576725396441, 7055.964720176417, 7058.470614703918, 26993.730062699316, 27334.863325683244, 27524.862375687993, 27617.309567260778, 27892.442151157065, 2969.3505665863363, 2970.2722832906074, 3067.4325249828853, 3141.952870706941, 3195.744340452758, 12437.751244975141, 16449.342026318933, 16500.92743971638, 16977.405790797264, 16985.660286794195, 1927.209843963968, 2069.596428696405, 2104.715863358442, 2130.776268491817, 2133.9466513337134, 118196.0, 118692.40653796762, 141099.29450352784, 148158.51841481554, 170307.0, 19942.60114797725, 20802.58394832125, 20957.371278861658, 20991.16035358599, 21185.0, 32531.67468325334, 33136.3372732544, 33294.50058249128, 33296.3340733184, 33333.499997500054, 10636.840447393295, 10769.730756730987, 10952.0, 10963.945180274048, 11146.777064458665, 9077.04691007448, 9088.636454541744, 9090.90909090914, 9245.0, 9248.398854074463, 7899.210078992055, 9466.337356385126, 9602.66390676323, 9635.807283854283, 9825.361351512129, 3476.4090104682264, 3502.2470168913806, 3772.490713753608, 3928.7249892507252, 4016.879493615196, 988.7577543501744, 1123.3652986063012, 1124.4033472469114, 1154.8036833738286, 1168.1414160591958, 20542.69185962212, 21941.890290548763, 23110.53778924412, 23138.768612313663, 23149.0, 1044.603050840691, 1106.1316866259947, 1107.5403707461473, 1117.0, 1155.8844115588543, 9740.512974351253, 11710.70723231926, 11792.0, 11972.341521216242, 12005.0, 642930.0, 654693.7265313643, 693140.0, 703763.0, 734580.0, 105789.47105264578, 127682.0, 145596.0, 148124.0, 153104.468955309, 1227.742174143422, 1233.6052463211865, 1265.7595056939151, 1268.2010333489843, 1272.5864094169433, 15029.473968411054, 20746.792532074487, 20927.927972790556, 21222.681659775426, 21253.6811947824, 46514.53485465102, 60398.0, 62854.74290514072, 63043.369566305584, 65087.37281567809, 82836.0, 83789.90525236918, 85122.72315915143, 85222.72165917393, 85385.14614853772, 11062.612808551663, 11275.04162146194, 11576.594819181288, 11795.941020295188, 12010.75978480443, 13044.282564459047, 13159.934200328937, 13281.66795830112, 13493.662658433617, 13509.797353039516, 11396.886031139582, 11530.135239856876, 11588.188826782382, 11927.4036298183, 11936.045116390842, 9200.447973121634, 10262.846057308998, 10324.845127322946, 10679.679609611723, 10766.784664306513, 11146.832797508207, 11608.593699220486, 11635.47640356203, 11871.228370155912, 11925.880741192477, 11578.884211157781, 11636.243644163102, 11762.58830940913, 11877.406129693654, 11973.521059157536, 11223.158263130135, 11376.544938202711, 11566.190366674253, 11644.72927779075, 11664.475098620413], "value": 11819.458455814849, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1625.081828766746, 1639.5573195237287, 1660.1035440861936, 1662.2602941690952, 1678.6223099802542, 11032.50353734082, 11739.354335511543, 11744.882551174507, 11753.177277590572, 11754.471048802803, 11038.11695064395, 11314.37770922599, 11321.0, 11518.654440366803, 11547.942260288708, 2491.5266099441137, 2528.962065569018, 2533.9239822805343, 2534.125726624321, 2546.656201412804, 2399.6520504526834, 2429.501952099824, 2432.1001229545095, 2434.914777982771, 2481.900723971039, 2134.9146034158616, 2483.987580062097, 2500.2999160235163, 2516.1570873757223, 2523.3187039499326, 2436.074291769134, 2453.1168779239547, 2462.4582591829767, 2468.1361523466735, 2510.397504598883, 2448.571499987495, 2474.5669507836055, 2495.987520062406, 2502.51201015802, 2511.9246422607353, 11478.713032174179, 11565.190436669436, 11567.479463424166, 11578.53685852565, 11641.6507504775, 5978.461938425519, 6158.230221222348, 6161.599496032788, 6194.4425001749605, 6211.4409703126485, 3675.687566556846, 3777.886663400075, 3791.9620803791886, 3857.4406711026745, 3868.5357757069332, 1310.7706151423463, 1905.7808352039553, 1935.5644979879555, 1957.4812674641232, 1990.3630838131803, 14332.785008224884, 14646.633834154125, 15061.849381506154, 15251.694966100727, 15398.461053863173, 4196.559361267084, 4475.932861007088, 4504.909901801946, 4581.518940511265, 4962.627802914796, 12128.393580320948, 12150.756984860252, 12154.392280386122, 12188.207766495327, 12231.816522752166, 6104.542159338067, 6113.449789518876, 6114.510839132859, 6124.816255512342, 6128.3565225651555, 5463.672179669233, 5511.366192887789, 5556.027695153332, 5632.802851900164, 5655.321361436571, 4004.9989544988293, 4081.510218773766, 4121.5878412158545, 4169.958300417018, 4173.08192197716, 1080.1790639114329, 1081.1999120650662, 1082.6373164989816, 1098.5715570927346, 1100.0, 942.29328003997, 967.3277072434731, 970.8207260785052, 971.5482300730054, 972.5331840716495, 6894.034835123087, 7032.226455089936, 7035.718571257093, 7053.612051337123, 7135.1437827459995, 982.8771403574553, 1013.1692012549638, 1023.498485741996, 1037.6316407675317, 1070.1920050361928, 4265.658747300208, 4400.427944367212, 4430.778461076933, 4484.103179364075, 4602.631789456836, 13685.589432316847, 14317.997740158296, 14326.355314010894, 14344.928275358556, 14362.0, 11612.245204061877, 11998.0, 13376.0, 14077.788833167511, 14105.224212668196, 8822.823543529094, 9103.635854565744, 10201.795964080826, 10478.842817357745, 10526.263161578616, 5583.525400341016, 7159.355657990805, 7362.263773622595, 7394.0, 7395.964564960802, 10440.0, 10563.63027294041, 12065.215760975509, 12265.38673066361, 12284.0, 11570.305781653127, 12790.808137877753, 12854.100212985002, 12900.741985160432, 13179.0, 9314.44113353201, 9561.665341713007, 9576.186024188022, 9584.66453674118, 9585.137337639646, 10402.947985260025, 10535.209859260432, 10537.946205379401, 10639.521221544894, 10686.25196236256, 8979.506127162807, 9090.318226133199, 9150.771230719285, 9156.0, 9300.674476393293, 8129.7967550809335, 8864.468131912106, 8869.06874778139, 8935.195832375117, 8938.553072346487, 7927.454146441389, 8341.833163336578, 8344.66621335164, 8354.289885359813, 8354.540500272544, 5294.258803767399, 5918.23063001807, 5931.9406805931385, 6120.632762034292, 6168.25980882297, 6030.547708921761, 6092.116643086816, 6122.602030867979, 6179.721912514037, 6345.524085693499], "value": 5353.438801252696, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.7007004606453, 391.74732297667987, 393.55921368067766, 400.85769551809113, 401.50815251317124, 4597.046255341479, 5180.886553866436, 5226.477352264772, 5245.79016839326, 5274.993253845305, 4203.873883783492, 4526.524714904937, 4989.877277612535, 5153.81961631343, 5171.870703232421, 4099.642705444381, 4113.588641135892, 4113.938290925638, 4121.845883152722, 4140.937885931706, 3560.287942411515, 4113.25961326961, 4120.155368149537, 4140.875773726778, 4158.397032430295, 3578.57057153142, 3942.664873485757, 4105.876823695279, 4136.607981455208, 4159.646430053449, 3508.561429821272, 3533.9646603533893, 3604.7743767119305, 4125.834966601333, 4395.362672412514, 3408.2222988264734, 3512.2799826035603, 3816.713746469026, 4026.315526360526, 4034.2536630723116, 4184.2050010498215, 4618.745968971705, 4858.105338917825, 5127.179851152824, 5208.583313334924, 4488.8877778055485, 4594.151625991873, 4875.6840500761855, 5012.248162775576, 5050.343455350818, 4765.451228350766, 5622.0, 5634.6337488063555, 5667.489925906688, 5693.516051135658, 3976.443297938291, 4557.544245575449, 4597.7011494252765, 4620.059574978483, 4637.536246375369, 5488.890222195534, 5683.886322273532, 5807.548112971757, 5903.2325797646035, 5957.987142185795, 3811.6378944000276, 4145.461090058334, 4665.486796452387, 4686.554777296152, 4748.934213617088, 4787.558345243881, 4819.3012013258585, 4832.251001094836, 4863.416390033219, 4873.661541843849, 4389.670774691911, 4419.751482660242, 4515.9774201128785, 4684.742339171378, 5061.44324124346, 5507.779688812483, 5509.721715579224, 5527.0, 5550.777968881281, 5660.915086273709, 1431.484665520412, 1452.8256609206962, 1453.9200343980972, 1462.4881291547872, 1596.9259176085989, 995.716220877061, 1132.4960392625203, 1161.4134861894688, 1207.9516819327305, 1215.3046500132266, 4849.830255941025, 5279.498447647467, 5303.942483999744, 5305.62860599762, 5337.185356978646, 5076.568491678175, 5720.827230417837, 5733.620547472836, 5814.883702325929, 5830.737616807254, 4622.699524530894, 4634.0, 5098.770555324945, 5152.458991805806, 5189.31347312125, 2695.5148073346986, 2837.5459926411677, 3038.7844862055354, 3052.9236769080508, 3065.708757668018, 4988.451270360258, 5441.455854414606, 5627.296587926509, 5797.913031304533, 5914.9704251479325, 4735.082291671878, 5895.263092113486, 5922.009385260416, 5959.821205363846, 5975.133605627247, 4937.975310123426, 5062.7468626568525, 5265.868353291198, 5308.619758862724, 5972.431090215901, 5088.829569199179, 5606.1408681571875, 5743.8644176193075, 5751.654900705971, 5818.505427038749, 4715.22198837188, 5172.7068232941765, 5811.883762324645, 5818.9342783313, 5820.76716931318, 4783.679915241175, 5229.633925625322, 5317.909828485229, 5359.365393554847, 5769.451902069297, 4284.151039558658, 4456.952616135271, 4727.163701779043, 4739.099571081483, 4741.454732705783, 5410.810621628224, 5697.7720891165545, 5707.20099186106, 5779.971100144472, 5901.350851406256, 5170.1727723564045, 5321.685066995869, 5555.30558680165, 5556.472135147154, 5567.081431563746, 4775.665703400868, 5270.657407268515, 5500.559955203654, 5623.803166889139, 5675.779707362937, 5413.215083812904, 5466.671999680032, 5482.205080263259, 5485.588580856372, 5496.422875598005, 5551.528844856197, 5569.220309156803, 5569.693666848362, 5611.494965453129, 5611.775528978958, 4796.8081276748535, 5421.701806400686, 5443.319585051869, 5465.64977059868, 5479.863003424787], "value": 4244.941391958869, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [765.2500549461531, 786.7993661616287, 807.9636416361263, 899.4468401932811, 900.1616312321271, 15555.533333999983, 16672.58318542037, 17194.3122275109, 18108.366207182753, 18308.633827323447, 15538.689226215469, 15759.133247671374, 15771.369145234206, 16308.673826523493, 16836.410725624606, 998.1104701888048, 1024.196006135184, 1025.3540269630123, 1027.4297764740566, 1030.876294844616, 987.0474991633073, 1001.8397056470966, 1030.8814486334093, 1034.9120324772366, 1039.6932904793105, 1047.0942634621074, 1047.2198212331823, 1047.8794938582084, 1048.4024106259435, 1048.6696690542492, 1032.9070383665505, 1035.7514196592763, 1035.9067683908447, 1037.1495373793493, 1039.77644806367, 772.5982489105689, 772.8067983004249, 773.4585789947059, 774.040190164198, 776.0144616337277, 17411.825881741148, 17498.037607931557, 17500.474985750447, 18209.99845008524, 18428.723569146474, 14744.557663270012, 14977.326020329112, 15069.246537673182, 15143.924280378527, 15337.539873803804, 11893.40532973348, 12083.758324833454, 12347.320897350643, 12538.749225015448, 12643.936780316131, 3755.9436608450897, 3796.3356412627954, 3959.0894094358173, 3994.460747799039, 4080.2451546463703, 110433.44783276113, 115413.845861542, 118142.40928795387, 119938.40030799877, 122251.0, 11402.543898243977, 11500.25248358854, 11582.594609188638, 11749.0, 11770.764584708259, 24106.638400424006, 24186.395340116287, 24447.777611119374, 24568.385790355384, 24602.384940376276, 7910.802229944183, 8037.115917249098, 8063.717769878026, 8127.552984585905, 8245.8350832983, 4629.282461218517, 4629.398178236807, 4673.345731597579, 4674.5325467452985, 4754.500777418321, 3614.963850361463, 3672.467492213614, 3685.355062863988, 3707.2029513654693, 3715.21980384117, 638.8498702804837, 639.5139693832721, 642.3672682407824, 655.7606473637088, 663.3002182697204, 613.6992873491956, 705.6930235347537, 733.3509843788286, 735.9632018399059, 766.4941138848334, 10615.628453004263, 10823.67528974132, 11095.72260693489, 11160.497777600027, 11307.434628268718, 696.7805141380449, 733.3986131372224, 743.8140464883779, 755.9659815308324, 761.919998400171, 4911.45973942866, 5140.331756871583, 5262.105442074857, 5274.208868669653, 5282.81510147143, 106020.0, 108469.91530084756, 109371.90628093776, 109684.0, 109990.45004775086, 54353.72823135938, 60833.391666082774, 77475.0, 84429.31141377261, 86960.0, 78347.0, 78373.8243926353, 80134.79797803154, 80753.59623201846, 81147.7827832583, 9793.314467987457, 10839.512221950188, 11014.118870490502, 11327.207095503236, 11407.37259450705, 48334.516654833, 52218.0, 52629.94740105253, 53258.0, 53571.7321413406, 54773.45226547684, 66879.32801679998, 67170.66414668091, 68189.65905170442, 68952.0, 13165.802512962506, 13230.801537977131, 13493.190408575518, 13692.52076177329, 14008.949328800585, 15126.0, 15487.606115449664, 15647.530574082795, 15737.68524629524, 15765.448209313077, 11700.765984680429, 14043.929780351442, 14229.359678814271, 14587.781183282046, 14590.416383344547, 11948.430171222475, 11970.802919708309, 11972.700682483008, 12197.32914689665, 12372.876271237172, 11995.940020299842, 12072.818907716215, 12282.078844086907, 12577.371131443208, 12642.87357126417, 8890.86663700058, 9029.051949545203, 9250.907490925005, 9373.625054997996, 9672.903270967201, 8542.487450752975, 9426.434413935185, 9903.762029746282, 10490.52792624349, 10813.513391897226], "value": 7907.180546764685, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1424.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 115.0, 165.0, 168.0, 116.0, 115.0, 93.0, 120.0, 168.0, 169.0], "value": 133.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 108.0, 105.0, 134.0, 109.0, 108.0, 107.0, 104.0, 125.0, 107.0], "value": 114.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 181.0, 182.0, 186.0, 182.0, 185.0, 184.0, 183.0, 185.0, 184.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 58.0, 88.0, 60.0, 61.0, 71.0, 80.0, 94.0, 57.0], "value": 71.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 69.0, 85.0, 68.0, 68.0, 68.0, 80.0, 68.0, 68.0, 81.0], "value": 74.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 88.0, 90.0, 88.0, 88.0, 88.0, 90.0, 89.0, 88.0, 88.0], "value": 88.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 95.0, 95.0, 94.0, 95.0, 96.0, 95.0, 97.0, 92.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 83.0, 84.0, 84.0, 98.0, 128.0, 106.0, 85.0, 85.0, 84.0], "value": 92.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 59.0, 59.0, 60.0, 62.0, 62.0, 63.0, 63.0, 63.0, 63.0], "value": 61.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 56.0, 55.0, 63.0, 59.0, 57.0, 58.0, 57.0, 58.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 80.0, 80.0, 80.0, 80.0, 80.0, 83.0, 82.0, 81.0, 87.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 143.0, 138.0, 134.0, 134.0, 134.0, 134.0, 135.0, 198.0, 168.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 160.0, 162.0, 161.0, 165.0, 159.0, 164.0, 161.0, 161.0], "value": 161.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 63.0, 63.0, 63.0, 63.0, 62.0], "value": 63.5, "unit": "score"}]}]} 05:59:20 INFO - Return code: 0 05:59:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:59:20 INFO - # TBPL SUCCESS # 05:59:20 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:59:20 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:59:20 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:59:20 INFO - 2017-05-09 05:59:20.514 screenresolution[1658:9853] starting screenresolution argv=screenresolution get 05:59:20 INFO - 2017-05-09 05:59:20.516 screenresolution[1658:9853] Display 0: 1600x1200x32@60 05:59:20 INFO - 2017-05-09 05:59:20.522 screenresolution[1659:9856] starting screenresolution argv=screenresolution list 05:59:20 INFO - Available Modes on Display 0 05:59:20 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:59:20 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:59:20 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:59:20 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:59:20 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:59:20 INFO - Intel Iris: 05:59:20 INFO - Chipset Model: Intel Iris 05:59:20 INFO - Type: GPU 05:59:20 INFO - Bus: Built-In 05:59:20 INFO - VRAM (Dynamic, Max): 1536 MB 05:59:20 INFO - Vendor: Intel (0x8086) 05:59:20 INFO - Device ID: 0x0a2e 05:59:20 INFO - Revision ID: 0x0009 05:59:20 INFO - Displays: 05:59:20 INFO - Display: 05:59:20 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:59:20 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:59:20 INFO - Display Serial Number: 1600x1200 60 05:59:20 INFO - Main Display: Yes 05:59:20 INFO - Mirror: Off 05:59:20 INFO - Online: Yes 05:59:20 INFO - Rotation: Supported 05:59:20 INFO - Return code: 0 05:59:20 INFO - Running post-action listener: _resource_record_post_action 05:59:20 INFO - [mozharness: 2017-05-09 12:59:20.757576Z] Finished run-tests step (success) 05:59:20 INFO - Running post-run listener: _resource_record_post_run 05:59:20 INFO - Total resource usage - Wall time: 1192s; CPU: 54.0%; Read bytes: 40850432; Write bytes: 420998656; Read time: 400; Write time: 1854 05:59:20 INFO - TinderboxPrint: CPU usage
53.9% 05:59:20 INFO - TinderboxPrint: I/O read bytes / time
40,850,432 / 400 05:59:20 INFO - TinderboxPrint: I/O write bytes / time
420,998,656 / 1,854 05:59:20 INFO - TinderboxPrint: CPU idle
2,197.0 (46.1%) 05:59:20 INFO - TinderboxPrint: CPU system
955.1 (20.0%) 05:59:20 INFO - TinderboxPrint: CPU user
1,617.6 (33.9%) 05:59:20 INFO - TinderboxPrint: Swap in / out
161,857,536 / 0 05:59:20 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 123099648; Write bytes: 125745152; Read time: 11132; Write time: 330 05:59:20 INFO - run-tests - Wall time: 1178s; CPU: 54.0%; Read bytes: 35615744; Write bytes: 293889536; Read time: 366; Write time: 1519 05:59:21 INFO - Running post-run listener: _upload_blobber_files 05:59:21 INFO - Blob upload gear active. 05:59:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:59:21 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 05:59:21 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'] 05:59:21 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 05:59:21 INFO - (blobuploader) - INFO - Open directory for files ... 05:59:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:59:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:59:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:22 INFO - (blobuploader) - INFO - Done attempting. 05:59:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:59:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:59:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:23 INFO - (blobuploader) - INFO - Done attempting. 05:59:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:59:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:24 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:59:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:24 INFO - (blobuploader) - INFO - Done attempting. 05:59:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:59:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:59:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:59:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:59:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:59:26 INFO - (blobuploader) - INFO - Done attempting. 05:59:26 INFO - (blobuploader) - INFO - Iteration through files over. 05:59:26 INFO - Return code: 0 05:59:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:59:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:59:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6f2c8d0235f488fc4d127925bc5505d59083adaea3ea31ec288658ef63a9a7730f95b36b36a4cfd92d388fca48638907886a39231defb8c56e3f4692e5ee41a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9969d868c5b8fdb2d0ed9eef20cb03641b5253f2a3eae4525521612c04070b93c4bfda2eb8e22020f5102b35545995f02686ff673a37d1f9d5795f7e2635f3ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f664d0acc28ff1eb866553b964e1d8d5823419e5c0d7c5bf3cb1021b7a9cdf34ba1b9fed35633df8642d15c1e9d47be2cc04069d63e43358001d54f4ca212b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d9b6b19f496883cfa5efafe47c134159cd7e3270c738aa427ee7997c441a60aa3374db8199edb1ff23b159cf6159f1d253e0c1f9745d66e248191cb7ba68bfe8"} 05:59:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:59:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:59:26 INFO - Contents: 05:59:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/e6f2c8d0235f488fc4d127925bc5505d59083adaea3ea31ec288658ef63a9a7730f95b36b36a4cfd92d388fca48638907886a39231defb8c56e3f4692e5ee41a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9969d868c5b8fdb2d0ed9eef20cb03641b5253f2a3eae4525521612c04070b93c4bfda2eb8e22020f5102b35545995f02686ff673a37d1f9d5795f7e2635f3ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f664d0acc28ff1eb866553b964e1d8d5823419e5c0d7c5bf3cb1021b7a9cdf34ba1b9fed35633df8642d15c1e9d47be2cc04069d63e43358001d54f4ca212b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d9b6b19f496883cfa5efafe47c134159cd7e3270c738aa427ee7997c441a60aa3374db8199edb1ff23b159cf6159f1d253e0c1f9745d66e248191cb7ba68bfe8"} 05:59:26 INFO - Running post-run listener: copy_logs_to_upload_dir 05:59:26 INFO - Copying logs to upload dir... 05:59:26 INFO - mkdir: /builds/slave/test/build/upload/logs 05:59:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1268.826031 ========= master_lag: 2.81 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-05-09 05:59:29.422631) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 05:59:29.426075) ========= 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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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/e6f2c8d0235f488fc4d127925bc5505d59083adaea3ea31ec288658ef63a9a7730f95b36b36a4cfd92d388fca48638907886a39231defb8c56e3f4692e5ee41a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9969d868c5b8fdb2d0ed9eef20cb03641b5253f2a3eae4525521612c04070b93c4bfda2eb8e22020f5102b35545995f02686ff673a37d1f9d5795f7e2635f3ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f664d0acc28ff1eb866553b964e1d8d5823419e5c0d7c5bf3cb1021b7a9cdf34ba1b9fed35633df8642d15c1e9d47be2cc04069d63e43358001d54f4ca212b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d9b6b19f496883cfa5efafe47c134159cd7e3270c738aa427ee7997c441a60aa3374db8199edb1ff23b159cf6159f1d253e0c1f9745d66e248191cb7ba68bfe8"} build_url:https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011090 build_url: 'https://queue.taskcluster.net/v1/task/AcbJbKkKToGm9PQORSKICg/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/e6f2c8d0235f488fc4d127925bc5505d59083adaea3ea31ec288658ef63a9a7730f95b36b36a4cfd92d388fca48638907886a39231defb8c56e3f4692e5ee41a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9969d868c5b8fdb2d0ed9eef20cb03641b5253f2a3eae4525521612c04070b93c4bfda2eb8e22020f5102b35545995f02686ff673a37d1f9d5795f7e2635f3ce", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8f664d0acc28ff1eb866553b964e1d8d5823419e5c0d7c5bf3cb1021b7a9cdf34ba1b9fed35633df8642d15c1e9d47be2cc04069d63e43358001d54f4ca212b7", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d9b6b19f496883cfa5efafe47c134159cd7e3270c738aa427ee7997c441a60aa3374db8199edb1ff23b159cf6159f1d253e0c1f9745d66e248191cb7ba68bfe8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-09 05:59:29.470286) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2017-05-09 05:59:29.470569) ========= 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.xXOUOB5Hpa/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.xBOWTmP0EV/Listeners TMPDIR=/var/folders/s9/h01r07gs45gfv0h9php9jq_000000w/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.005227 ========= master_lag: 4.51 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 4 secs) (at 2017-05-09 05:59:33.989322) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 05:59:33.989633) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-09 05:59:33.992464) ========= ========= Total master_lag: 9.46 =========