builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0357 starttime: 1487731832.6 results: success (0) buildid: 20170221173528 builduid: 4a91cddb3167489e9136383fe7b6ddba revision: 9f871c40b36f164a3413c5aea5c4434f080a7bf0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:32.601891) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:32.602424) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:32.602727) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:32.630361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:32.630885) ========= 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.DMVyblYW6g/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.nVqgUMz221/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-02-21 18:50:32-- 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% 14.1M=0.001s 2017-02-21 18:50:32 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118960 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:32.774715) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:32.775060) ========= 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.DMVyblYW6g/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.nVqgUMz221/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.025636 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:32.823871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-21 18:50:32.824220) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9f871c40b36f164a3413c5aea5c4434f080a7bf0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 9f871c40b36f164a3413c5aea5c4434f080a7bf0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DMVyblYW6g/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.nVqgUMz221/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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-02-21 18:50:32,930 truncating revision to first 12 chars 2017-02-21 18:50:32,930 Setting DEBUG logging. 2017-02-21 18:50:32,930 attempt 1/10 2017-02-21 18:50:32,930 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9f871c40b36f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-21 18:50:34,643 unpacking tar archive at: mozilla-central-9f871c40b36f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.011037 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-21 18:50:34.859965) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:34.860470) ========= script_repo_revision: 9f871c40b36f164a3413c5aea5c4434f080a7bf0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:34.860881) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:34.861317) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-21 18:50:34.882229) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-21 18:50:34.882616) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DMVyblYW6g/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.nVqgUMz221/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:50:35 INFO - MultiFileLogger online at 20170221 18:50:35 in /builds/slave/test 18:50:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 18:50:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:50:35 INFO - {'append_to_log': False, 18:50:35 INFO - 'base_work_dir': '/builds/slave/test', 18:50:35 INFO - 'blob_upload_branch': 'Firefox', 18:50:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:50:35 INFO - 'branch': 'Firefox', 18:50:35 INFO - 'buildbot_json_path': 'buildprops.json', 18:50:35 INFO - 'config_files': ('talos/mac_config.py',), 18:50:35 INFO - 'default_actions': ('clobber', 18:50:35 INFO - 'read-buildbot-config', 18:50:35 INFO - 'download-and-extract', 18:50:35 INFO - 'populate-webroot', 18:50:35 INFO - 'create-virtualenv', 18:50:35 INFO - 'install', 18:50:35 INFO - 'run-tests'), 18:50:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:50:35 INFO - 'download_minidump_stackwalk': True, 18:50:35 INFO - 'download_symbols': 'ondemand', 18:50:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:50:35 INFO - 'tooltool.py': '/tools/tooltool.py', 18:50:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:50:35 INFO - '/tools/misc-python/virtualenv.py')}, 18:50:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:50:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:50:35 INFO - 'gecko_profile': False, 18:50:35 INFO - 'gecko_profile_interval': 0, 18:50:35 INFO - 'installer_path': 'installer.exe', 18:50:35 INFO - 'log_level': 'info', 18:50:35 INFO - 'log_name': 'talos', 18:50:35 INFO - 'log_to_console': True, 18:50:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:50:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:50:35 INFO - 'opt_config_files': (), 18:50:35 INFO - 'pip_index': False, 18:50:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:50:35 INFO - 'cmd': ('bash', 18:50:35 INFO - '-c', 18:50:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:50:35 INFO - 'enabled': True, 18:50:35 INFO - 'halt_on_failure': False, 18:50:35 INFO - 'name': 'check_screen_resolution'},), 18:50:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:50:35 INFO - 'cmd': ('bash', 18:50:35 INFO - '-c', 18:50:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:50:35 INFO - 'enabled': True, 18:50:35 INFO - 'halt_on_failure': False, 18:50:35 INFO - 'name': 'check_screen_resolution'},), 18:50:35 INFO - 'run_cmd_checks_enabled': True, 18:50:35 INFO - 'suite': 'dromaeojs', 18:50:35 INFO - 'system_bits': '32', 18:50:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:50:35 INFO - 'title': 't-yosemite-r7-0357', 18:50:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:50:35 INFO - 'use_talos_json': True, 18:50:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:50:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:50:35 INFO - 'work_dir': 'build'} 18:50:35 INFO - [mozharness: 2017-02-22 02:50:35.098260Z] Running clobber step. 18:50:35 INFO - Running pre-action listener: _resource_record_pre_action 18:50:35 INFO - Running main action method: clobber 18:50:35 INFO - rmtree: /builds/slave/test/build 18:50:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:50:37 INFO - Running post-action listener: _resource_record_post_action 18:50:37 INFO - [mozharness: 2017-02-22 02:50:37.459243Z] Finished clobber step (success) 18:50:37 INFO - [mozharness: 2017-02-22 02:50:37.459388Z] Running read-buildbot-config step. 18:50:37 INFO - Running pre-action listener: _resource_record_pre_action 18:50:37 INFO - Running main action method: read_buildbot_config 18:50:37 INFO - Using buildbot properties: 18:50:37 INFO - { 18:50:37 INFO - "project": "", 18:50:37 INFO - "product": "firefox", 18:50:37 INFO - "script_repo_revision": "production", 18:50:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 18:50:37 INFO - "repository": "", 18:50:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 18:50:37 INFO - "buildid": "20170221173528", 18:50:37 INFO - "pgo_build": "False", 18:50:37 INFO - "basedir": "/builds/slave/test", 18:50:37 INFO - "buildnumber": 2, 18:50:37 INFO - "slavename": "t-yosemite-r7-0357", 18:50:37 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 18:50:37 INFO - "platform": "yosemite_r7", 18:50:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:50:37 INFO - "branch": "mozilla-central", 18:50:37 INFO - "repo_path": "mozilla-central", 18:50:37 INFO - "revision": "9f871c40b36f164a3413c5aea5c4434f080a7bf0", 18:50:37 INFO - "stage_platform": "macosx64", 18:50:37 INFO - "builduid": "4a91cddb3167489e9136383fe7b6ddba", 18:50:37 INFO - "slavebuilddir": "test" 18:50:37 INFO - } 18:50:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 18:50:37 INFO - Running post-action listener: _resource_record_post_action 18:50:37 INFO - [mozharness: 2017-02-22 02:50:37.462750Z] Finished read-buildbot-config step (success) 18:50:37 INFO - [mozharness: 2017-02-22 02:50:37.462863Z] Running download-and-extract step. 18:50:37 INFO - Running pre-action listener: _resource_record_pre_action 18:50:37 INFO - Running main action method: download_and_extract 18:50:37 INFO - mkdir: /builds/slave/test/build/tests 18:50:37 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')]} 18:50:37 INFO - trying https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 18:50:37 INFO - Downloading https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:50:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 18:50:38 INFO - Downloaded 1199 bytes. 18:50:38 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 18:50:38 INFO - Using the following test package requirements: 18:50:38 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:50:38 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:50:38 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 18:50:38 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:50:38 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 18:50:38 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:50:38 INFO - u'jsshell-mac.zip'], 18:50:38 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:50:38 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 18:50:38 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 18:50:38 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:50:38 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 18:50:38 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:50:38 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 18:50:38 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:50:38 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 18:50:38 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 18:50:38 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 18:50:38 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:50:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:50:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:50:38 INFO - Fetch https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:50:40 INFO - Expected file size: 51464463 18:50:40 INFO - Obtained file size: 51464463 18:50:56 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 18:50:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 18:50:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 18:50:56 INFO - Fetch https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 18:50:58 INFO - Expected file size: 51464463 18:50:58 INFO - Obtained file size: 51464463 18:51:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 18:51:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 18:51:13 INFO - Fetch https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 18:51:14 INFO - Expected file size: 14404319 18:51:14 INFO - Obtained file size: 14404319 18:51:15 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')]} 18:51:15 INFO - trying https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:51:15 INFO - Downloading https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 18:51:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 18:51:17 INFO - Downloaded 74750498 bytes. 18:51:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:51:17 INFO - mkdir: /builds/slave/test/properties 18:51:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:51:17 INFO - Writing to file /builds/slave/test/properties/build_url 18:51:17 INFO - Contents: 18:51:17 INFO - build_url:https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 18:51:17 INFO - Running post-action listener: _resource_record_post_action 18:51:17 INFO - Running post-action listener: set_extra_try_arguments 18:51:17 INFO - [mozharness: 2017-02-22 02:51:17.863191Z] Finished download-and-extract step (success) 18:51:17 INFO - [mozharness: 2017-02-22 02:51:17.863331Z] Running populate-webroot step. 18:51:17 INFO - Running pre-action listener: _resource_record_pre_action 18:51:17 INFO - Running main action method: populate_webroot 18:51:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:51:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:51:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:51:17 INFO - '--tppagecycles', 18:51:17 INFO - '7'], 18:51:17 INFO - 'tests': ['tsvgm']}}, 18:51:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:51:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:51:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:51:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:51:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 18:51:17 INFO - 'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 18:51:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:51:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 18:51:17 INFO - 'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['damp', 'tps']}, 18:51:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 18:51:17 INFO - 'tests': ['damp', 'tps']}, 18:51:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['dromaeo_dom']}, 18:51:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:51:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['basic_compositor_video']}, 18:51:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:51:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['a11yr', 18:51:17 INFO - 'ts_paint', 18:51:17 INFO - 'tpaint', 18:51:17 INFO - 'sessionrestore', 18:51:17 INFO - 'sessionrestore_no_auto_restore', 18:51:17 INFO - 'tabpaint']}, 18:51:17 INFO - 'other-e10s': {'tests': ['a11yr', 18:51:17 INFO - 'ts_paint', 18:51:17 INFO - 'tpaint', 18:51:17 INFO - 'sessionrestore', 18:51:17 INFO - 'sessionrestore_no_auto_restore', 18:51:17 INFO - 'tabpaint']}, 18:51:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:51:17 INFO - 'ts_paint', 18:51:17 INFO - 'tpaint', 18:51:17 INFO - 'sessionrestore', 18:51:17 INFO - 'sessionrestore_no_auto_restore', 18:51:17 INFO - 'tabpaint']}, 18:51:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:51:17 INFO - 'ts_paint', 18:51:17 INFO - 'tpaint', 18:51:17 INFO - 'sessionrestore', 18:51:17 INFO - 'sessionrestore_no_auto_restore', 18:51:17 INFO - 'tabpaint']}, 18:51:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['a11yr', 18:51:17 INFO - 'ts_paint', 18:51:17 INFO - 'tpaint', 18:51:17 INFO - 'sessionrestore', 18:51:17 INFO - 'sessionrestore_no_auto_restore', 18:51:17 INFO - 'tabpaint']}, 18:51:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['a11yr', 18:51:17 INFO - 'ts_paint', 18:51:17 INFO - 'tpaint', 18:51:17 INFO - 'sessionrestore', 18:51:17 INFO - 'sessionrestore_no_auto_restore', 18:51:17 INFO - 'tabpaint']}, 18:51:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['tsvgx', 18:51:17 INFO - 'tsvgr_opacity', 18:51:17 INFO - 'tart', 18:51:17 INFO - 'tscrollx', 18:51:17 INFO - 'cart', 18:51:17 INFO - 'tsvg_static']}, 18:51:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:51:17 INFO - 'tsvgr_opacity', 18:51:17 INFO - 'tart', 18:51:17 INFO - 'tscrollx', 18:51:17 INFO - 'cart', 18:51:17 INFO - 'tsvg_static']}, 18:51:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 18:51:17 INFO - 'talos_options': ['--disable-e10s'], 18:51:17 INFO - 'tests': ['tp5o']}, 18:51:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 18:51:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 18:51:17 INFO - 'talos_options': ['--disable-e10s', 18:51:17 INFO - '--xperf_path', 18:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:17 INFO - 'tests': ['tp5n']}, 18:51:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 18:51:17 INFO - 'talos_options': ['--xperf_path', 18:51:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:51:17 INFO - 'tests': ['tp5n']}}, 18:51:17 INFO - 'talos.zip': {'path': '', 18:51:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:51:17 INFO - Running post-action listener: _resource_record_post_action 18:51:17 INFO - [mozharness: 2017-02-22 02:51:17.881713Z] Finished populate-webroot step (success) 18:51:17 INFO - [mozharness: 2017-02-22 02:51:17.881831Z] Running create-virtualenv step. 18:51:17 INFO - Running pre-action listener: _resource_record_pre_action 18:51:17 INFO - Running main action method: create_virtualenv 18:51:17 INFO - Creating virtualenv /builds/slave/test/build/venv 18:51:17 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 18:51:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:51:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:51:18 INFO - Using real prefix '/tools/python27' 18:51:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:51:18 INFO - Installing distribute.............................................................................................................................................................................................done. 18:51:21 INFO - Installing pip.................done. 18:51:21 INFO - Return code: 0 18:51:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:51:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:51:21 INFO - Reading from file tmpfile_stdout 18:51:21 INFO - Output received: 18:51:21 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) 18:51:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:21 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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:21 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 18:51:21 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 18:51:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:21 INFO - 'HOME': '/Users/cltbld', 18:51:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:21 INFO - 'LOGNAME': 'cltbld', 18:51:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:21 INFO - 'MOZ_NO_REMOTE': '1', 18:51:21 INFO - 'NO_EM_RESTART': '1', 18:51:21 INFO - 'PAGER': '/bin/cat', 18:51:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:21 INFO - 'PWD': '/builds/slave/test', 18:51:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:21 INFO - 'SHELL': '/bin/bash', 18:51:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:21 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:21 INFO - 'USER': 'cltbld', 18:51:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:21 INFO - 'XPC_FLAGS': '0x0', 18:51:21 INFO - 'XPC_SERVICE_NAME': '0', 18:51:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:22 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 18:51:22 INFO - Cleaning up... 18:51:22 INFO - Return code: 0 18:51:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:51: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')]} 18:51:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:51:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:51:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:22 INFO - 'HOME': '/Users/cltbld', 18:51:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:22 INFO - 'LOGNAME': 'cltbld', 18:51:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:22 INFO - 'MOZ_NO_REMOTE': '1', 18:51:22 INFO - 'NO_EM_RESTART': '1', 18:51:22 INFO - 'PAGER': '/bin/cat', 18:51:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:22 INFO - 'PWD': '/builds/slave/test', 18:51:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:22 INFO - 'SHELL': '/bin/bash', 18:51:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:22 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:22 INFO - 'USER': 'cltbld', 18:51:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:22 INFO - 'XPC_FLAGS': '0x0', 18:51:22 INFO - 'XPC_SERVICE_NAME': '0', 18:51:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:22 INFO - Downloading/unpacking psutil>=3.1.1 18:51:22 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 18:51:22 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 18:51:22 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 18:51:22 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 18:51:22 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 18:51:22 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 18:51:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:51:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:25 INFO - Installing collected packages: psutil 18:51:25 INFO - Running setup.py install for psutil 18:51:26 INFO - building 'psutil._psutil_osx' extension 18:51:26 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 18:51:26 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 18:51:26 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 18:51:26 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 18:51:26 INFO - building 'psutil._psutil_posix' extension 18:51:26 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 18:51:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:51:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:51:26 INFO - ^ 18:51:26 INFO - 1 warning generated. 18:51:26 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 18:51:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:51:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:51:27 INFO - Successfully installed psutil 18:51:27 INFO - Cleaning up... 18:51:27 INFO - Return code: 0 18:51:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:51: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')]} 18:51:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51: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')]} 18:51:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:28 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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:28 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 18:51:28 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 18:51:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:28 INFO - 'HOME': '/Users/cltbld', 18:51:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:28 INFO - 'LOGNAME': 'cltbld', 18:51:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:28 INFO - 'MOZ_NO_REMOTE': '1', 18:51:28 INFO - 'NO_EM_RESTART': '1', 18:51:28 INFO - 'PAGER': '/bin/cat', 18:51:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:28 INFO - 'PWD': '/builds/slave/test', 18:51:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:28 INFO - 'SHELL': '/bin/bash', 18:51:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:28 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:28 INFO - 'USER': 'cltbld', 18:51:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:28 INFO - 'XPC_FLAGS': '0x0', 18:51:28 INFO - 'XPC_SERVICE_NAME': '0', 18:51:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:51:28 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 18:51:28 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 18:51:28 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 18:51:28 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 18:51:28 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 18:51:28 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 18:51:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:51:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:51:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:51:31 INFO - Installing collected packages: mozsystemmonitor 18:51:31 INFO - Running setup.py install for mozsystemmonitor 18:51:31 INFO - Successfully installed mozsystemmonitor 18:51:31 INFO - Cleaning up... 18:51:31 INFO - Return code: 0 18:51:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:51:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:51:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:31 INFO - 'HOME': '/Users/cltbld', 18:51:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:31 INFO - 'LOGNAME': 'cltbld', 18:51:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:31 INFO - 'MOZ_NO_REMOTE': '1', 18:51:31 INFO - 'NO_EM_RESTART': '1', 18:51:31 INFO - 'PAGER': '/bin/cat', 18:51:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:31 INFO - 'PWD': '/builds/slave/test', 18:51:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:31 INFO - 'SHELL': '/bin/bash', 18:51:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:31 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:31 INFO - 'USER': 'cltbld', 18:51:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:31 INFO - 'XPC_FLAGS': '0x0', 18:51:31 INFO - 'XPC_SERVICE_NAME': '0', 18:51:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:32 INFO - Downloading/unpacking jsonschema==2.5.1 18:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:51:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:51:34 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 18:51:34 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 18:51:34 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 18:51:34 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 18:51:34 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 18:51:34 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 18:51:35 INFO - Downloading functools32-3.2.3-2.tar.gz 18:51:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:51:35 INFO - warning: no files found matching '*.txt' 18:51:35 INFO - no previously-included directories found matching 'build' 18:51:35 INFO - no previously-included directories found matching 'dist' 18:51:35 INFO - no previously-included directories found matching '.git*' 18:51:35 INFO - Installing collected packages: jsonschema, functools32 18:51:35 INFO - Running setup.py install for functools32 18:51:35 INFO - warning: no files found matching '*.txt' 18:51:35 INFO - no previously-included directories found matching 'build' 18:51:35 INFO - no previously-included directories found matching 'dist' 18:51:35 INFO - no previously-included directories found matching '.git*' 18:51:35 INFO - Successfully installed jsonschema functools32 18:51:35 INFO - Cleaning up... 18:51:35 INFO - Return code: 0 18:51:35 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:35 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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:35 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 18:51:35 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 18:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:35 INFO - 'HOME': '/Users/cltbld', 18:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:35 INFO - 'LOGNAME': 'cltbld', 18:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:35 INFO - 'MOZ_NO_REMOTE': '1', 18:51:35 INFO - 'NO_EM_RESTART': '1', 18:51:35 INFO - 'PAGER': '/bin/cat', 18:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:35 INFO - 'PWD': '/builds/slave/test', 18:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:35 INFO - 'SHELL': '/bin/bash', 18:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:35 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:35 INFO - 'USER': 'cltbld', 18:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:35 INFO - 'XPC_FLAGS': '0x0', 18:51:35 INFO - 'XPC_SERVICE_NAME': '0', 18:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:35 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:51:35 INFO - Cleaning up... 18:51:35 INFO - Return code: 0 18:51:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:35 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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:35 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 18:51:35 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 18:51:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:35 INFO - 'HOME': '/Users/cltbld', 18:51:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:35 INFO - 'LOGNAME': 'cltbld', 18:51:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:35 INFO - 'MOZ_NO_REMOTE': '1', 18:51:35 INFO - 'NO_EM_RESTART': '1', 18:51:35 INFO - 'PAGER': '/bin/cat', 18:51:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:35 INFO - 'PWD': '/builds/slave/test', 18:51:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:35 INFO - 'SHELL': '/bin/bash', 18:51:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:35 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:35 INFO - 'USER': 'cltbld', 18:51:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:35 INFO - 'XPC_FLAGS': '0x0', 18:51:35 INFO - 'XPC_SERVICE_NAME': '0', 18:51:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:35 INFO - Downloading/unpacking blobuploader==1.2.4 18:51:35 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 18:51:35 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 18:51:35 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 18:51:35 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 18:51:35 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 18:51:35 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 18:51:38 INFO - Downloading blobuploader-1.2.4.tar.gz 18:51:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:51:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:51:38 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 18:51:38 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 18:51:38 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 18:51:38 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 18:51:38 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 18:51:38 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 18:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:51:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:51:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:51:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:51:39 INFO - Downloading docopt-0.6.1.tar.gz 18:51:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:51:39 INFO - Installing collected packages: blobuploader, requests, docopt 18:51:39 INFO - Running setup.py install for blobuploader 18:51:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:51:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:51:40 INFO - Running setup.py install for requests 18:51:40 INFO - Running setup.py install for docopt 18:51:40 INFO - Successfully installed blobuploader requests docopt 18:51:40 INFO - Cleaning up... 18:51:40 INFO - Return code: 0 18:51:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:40 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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:40 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 18:51:40 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 18:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:40 INFO - 'HOME': '/Users/cltbld', 18:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:40 INFO - 'LOGNAME': 'cltbld', 18:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:40 INFO - 'MOZ_NO_REMOTE': '1', 18:51:40 INFO - 'NO_EM_RESTART': '1', 18:51:40 INFO - 'PAGER': '/bin/cat', 18:51:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:40 INFO - 'PWD': '/builds/slave/test', 18:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:40 INFO - 'SHELL': '/bin/bash', 18:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:40 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:40 INFO - 'USER': 'cltbld', 18:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:40 INFO - 'XPC_FLAGS': '0x0', 18:51:40 INFO - 'XPC_SERVICE_NAME': '0', 18:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:51:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Ekj7Rt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:51:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-WJfFCc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:51:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-ufPdd1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:51:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-EMMZfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:51:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-MfxN76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:51:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-MsxXO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:51:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-3AwiOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:51:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-m4oKYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:51:41 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-gnt17P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:51:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:51:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-8rzRra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:51:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-V1T_CR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:51:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-LPI4ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:51:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-twM2Zj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:51:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-nlU1ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Svkvzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:51:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-q8xHAK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:51:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:51:42 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-tY73aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:51:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:51:42 INFO - Running setup.py install for manifestparser 18:51:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:51:42 INFO - Running setup.py install for mozcrash 18:51:43 INFO - Running setup.py install for mozdebug 18:51:43 INFO - Running setup.py install for mozdevice 18:51:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Running setup.py install for mozfile 18:51:43 INFO - Running setup.py install for mozhttpd 18:51:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Running setup.py install for mozinfo 18:51:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Running setup.py install for mozInstall 18:51:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:51:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Running setup.py install for mozleak 18:51:44 INFO - Running setup.py install for mozlog 18:51:44 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Running setup.py install for moznetwork 18:51:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Running setup.py install for mozprocess 18:51:44 INFO - Running setup.py install for mozprofile 18:51:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Running setup.py install for mozrunner 18:51:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:51:44 INFO - Running setup.py install for mozscreenshot 18:51:45 INFO - Running setup.py install for moztest 18:51:45 INFO - Running setup.py install for mozversion 18:51:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:51:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:51:45 INFO - Cleaning up... 18:51:45 INFO - Return code: 0 18:51:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:45 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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:45 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 18:51:45 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 18:51:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:45 INFO - 'HOME': '/Users/cltbld', 18:51:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:45 INFO - 'LOGNAME': 'cltbld', 18:51:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:45 INFO - 'MOZ_NO_REMOTE': '1', 18:51:45 INFO - 'NO_EM_RESTART': '1', 18:51:45 INFO - 'PAGER': '/bin/cat', 18:51:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:45 INFO - 'PWD': '/builds/slave/test', 18:51:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:45 INFO - 'SHELL': '/bin/bash', 18:51:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:45 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:45 INFO - 'USER': 'cltbld', 18:51:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:45 INFO - 'XPC_FLAGS': '0x0', 18:51:45 INFO - 'XPC_SERVICE_NAME': '0', 18:51:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:51:45 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-Yf0ptG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:51:45 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)) 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:51:45 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-DJUlJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:51:45 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)) 18:51:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:51:45 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-yp6k67-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-KrzMNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-o2PMiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-voMSeJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-dQxjl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-QWQcdi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-rIbkj0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-02vBNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-dPImjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-RIccSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:51:46 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)) 18:51:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:51:46 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-eSx8n_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:51:47 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)) 18:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:51:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-zyU0gI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:51:47 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)) 18:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-cbGCbI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:51:47 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)) 18:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:51:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-HKE2s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:51:47 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)) 18:51:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:51:47 INFO - Running setup.py (path:/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/pip-MfHJIx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:51:47 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)) 18:51:47 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)) 18:51:47 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)) 18:51:47 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)) 18:51:47 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)) 18:51:47 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)) 18:51:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:51:47 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 18:51:47 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 18:51:47 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 18:51:47 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 18:51:47 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 18:51:47 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 18:51:50 INFO - Downloading blessings-1.6.tar.gz 18:51:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:51:50 INFO - Installing collected packages: blessings 18:51:50 INFO - Running setup.py install for blessings 18:51:50 INFO - Successfully installed blessings 18:51:50 INFO - Cleaning up... 18:51:50 INFO - Return code: 0 18:51:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:51:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:50 INFO - Reading from file tmpfile_stdout 18:51:50 INFO - Current package versions: 18:51:50 INFO - blessings == 1.6 18:51:50 INFO - blobuploader == 1.2.4 18:51:50 INFO - docopt == 0.6.1 18:51:50 INFO - functools32 == 3.2.3-2 18:51:50 INFO - jsonschema == 2.5.1 18:51:50 INFO - manifestparser == 1.1 18:51:50 INFO - mozInstall == 1.12 18:51:50 INFO - mozcrash == 1.0 18:51:50 INFO - mozdebug == 0.1 18:51:50 INFO - mozdevice == 0.49 18:51:50 INFO - mozfile == 1.2 18:51:50 INFO - mozhttpd == 0.7 18:51:50 INFO - mozinfo == 0.9 18:51:50 INFO - mozleak == 0.1 18:51:50 INFO - mozlog == 3.4 18:51:50 INFO - moznetwork == 0.27 18:51:50 INFO - mozprocess == 0.25 18:51:50 INFO - mozprofile == 0.28 18:51:50 INFO - mozrunner == 6.13 18:51:50 INFO - mozscreenshot == 0.1 18:51:50 INFO - mozsystemmonitor == 0.3 18:51:50 INFO - moztest == 0.8 18:51:50 INFO - mozversion == 1.4 18:51:50 INFO - psutil == 3.1.1 18:51:50 INFO - requests == 1.2.3 18:51:50 INFO - wsgiref == 0.1.2 18:51:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:50 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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:50 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 18:51:50 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 18:51:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:50 INFO - 'HOME': '/Users/cltbld', 18:51:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:50 INFO - 'LOGNAME': 'cltbld', 18:51:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:50 INFO - 'MOZ_NO_REMOTE': '1', 18:51:50 INFO - 'NO_EM_RESTART': '1', 18:51:50 INFO - 'PAGER': '/bin/cat', 18:51:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:50 INFO - 'PWD': '/builds/slave/test', 18:51:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:50 INFO - 'SHELL': '/bin/bash', 18:51:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:50 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:50 INFO - 'USER': 'cltbld', 18:51:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:50 INFO - 'XPC_FLAGS': '0x0', 18:51:50 INFO - 'XPC_SERVICE_NAME': '0', 18:51:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:51 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)) 18:51:51 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)) 18:51:51 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)) 18:51:51 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)) 18:51:51 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)) 18:51:51 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)) 18:51:51 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)) 18:51:51 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)) 18:51:51 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)) 18:51:51 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)) 18:51:51 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)) 18:51:51 INFO - Cleaning up... 18:51:51 INFO - Return code: 0 18:51:51 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:51:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:51:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:51:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:51:51 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 0x10e003b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e006768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda13c95980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, '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.DMVyblYW6g/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.nVqgUMz221/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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 18:51:51 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 18:51:51 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 18:51:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:51:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:51:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:51:51 INFO - 'HOME': '/Users/cltbld', 18:51:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:51:51 INFO - 'LOGNAME': 'cltbld', 18:51:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:51:51 INFO - 'MOZ_NO_REMOTE': '1', 18:51:51 INFO - 'NO_EM_RESTART': '1', 18:51:51 INFO - 'PAGER': '/bin/cat', 18:51:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:51:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:51:51 INFO - 'PWD': '/builds/slave/test', 18:51:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:51:51 INFO - 'SHELL': '/bin/bash', 18:51:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:51:51 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:51:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:51:51 INFO - 'USER': 'cltbld', 18:51:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:51:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:51:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:51:51 INFO - 'XPC_FLAGS': '0x0', 18:51:51 INFO - 'XPC_SERVICE_NAME': '0', 18:51:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:51:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:51:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:51:51 INFO - Cleaning up... 18:51:51 INFO - Return code: 0 18:51:51 INFO - Running post-action listener: _resource_record_post_action 18:51:51 INFO - Running post-action listener: _start_resource_monitoring 18:51:51 INFO - Starting resource monitoring. 18:51:51 INFO - [mozharness: 2017-02-22 02:51:51.388360Z] Finished create-virtualenv step (success) 18:51:51 INFO - [mozharness: 2017-02-22 02:51:51.389305Z] Running install step. 18:51:51 INFO - Running pre-action listener: _resource_record_pre_action 18:51:51 INFO - Running main action method: install 18:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:51:51 INFO - Reading from file tmpfile_stdout 18:51:51 INFO - Detecting whether we're running mozinstall >=1.0... 18:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:51:51 INFO - Reading from file tmpfile_stdout 18:51:51 INFO - Output received: 18:51:51 INFO - Usage: mozinstall [options] installer 18:51:51 INFO - Options: 18:51:51 INFO - -h, --help show this help message and exit 18:51:51 INFO - -d DEST, --destination=DEST 18:51:51 INFO - Directory to install application into. [default: 18:51:51 INFO - "/builds/slave/test"] 18:51:51 INFO - --app=APP Application being installed. [default: firefox] 18:51:51 INFO - mkdir: /builds/slave/test/build/application 18:51:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 18:51:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 18:52:11 INFO - Reading from file tmpfile_stdout 18:52:11 INFO - Output received: 18:52:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:52:11 INFO - Running post-action listener: _resource_record_post_action 18:52:11 INFO - [mozharness: 2017-02-22 02:52:11.560088Z] Finished install step (success) 18:52:11 INFO - [mozharness: 2017-02-22 02:52:11.560264Z] Running run-tests step. 18:52:11 INFO - Running pre-action listener: _resource_record_pre_action 18:52:11 INFO - Running main action method: run_tests 18:52:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:52:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:52:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:52:11 INFO - 2017-02-21 18:52:11.574 screenresolution[1634:7391] starting screenresolution argv=screenresolution get 18:52:11 INFO - 2017-02-21 18:52:11.577 screenresolution[1634:7391] Display 0: 1600x1200x32@60 18:52:11 INFO - 2017-02-21 18:52:11.583 screenresolution[1635:7394] starting screenresolution argv=screenresolution list 18:52:11 INFO - Available Modes on Display 0 18:52:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:52:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:52:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:52:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:52:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:52:11 INFO - Intel Iris: 18:52:11 INFO - Chipset Model: Intel Iris 18:52:11 INFO - Type: GPU 18:52:11 INFO - Bus: Built-In 18:52:11 INFO - VRAM (Dynamic, Max): 1536 MB 18:52:11 INFO - Vendor: Intel (0x8086) 18:52:11 INFO - Device ID: 0x0a2e 18:52:11 INFO - Revision ID: 0x0009 18:52:11 INFO - Displays: 18:52:11 INFO - Display: 18:52:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:52:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:52:11 INFO - Display Serial Number: 1600x1200 60 18:52:11 INFO - Main Display: Yes 18:52:11 INFO - Mirror: Off 18:52:11 INFO - Online: Yes 18:52:11 INFO - Rotation: Supported 18:52:11 INFO - Return code: 0 18:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:52:11 INFO - Python 2.7.3 18:52:11 INFO - Return code: 0 18:52:11 INFO - grabbing minidump binary from tooltool 18:52: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')]} 18:52:11 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 0x10dde1d30>, '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 0x10dd08db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:52:11 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 18:52:11 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 18:52:11 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 18:52:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:52:11 INFO - Return code: 0 18:52:11 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:52:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:52:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:52:11 INFO - ENV: RUST_BACKTRACE is now 1 18:52:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:52:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 18:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0357 --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 18:52:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DMVyblYW6g/Render', 18:52:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:52:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:52:11 INFO - 'HOME': '/Users/cltbld', 18:52:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:52:11 INFO - 'LOGNAME': 'cltbld', 18:52:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:52:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:52:11 INFO - 'MOZ_NO_REMOTE': '1', 18:52:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:52:11 INFO - 'NO_EM_RESTART': '1', 18:52:11 INFO - 'PAGER': '/bin/cat', 18:52:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:52:11 INFO - 'PWD': '/builds/slave/test', 18:52:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:52:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:52:11 INFO - 'RUST_BACKTRACE': '1', 18:52:11 INFO - 'SHELL': '/bin/bash', 18:52:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nVqgUMz221/Listeners', 18:52:11 INFO - 'TMPDIR': '/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/', 18:52:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:52:11 INFO - 'USER': 'cltbld', 18:52:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:52:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:52:11 INFO - 'XPC_FLAGS': '0x0', 18:52:11 INFO - 'XPC_SERVICE_NAME': '0', 18:52:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:52:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0357', '--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 18:52:12 INFO - mozversion application_buildid: 20170221173528 18:52:12 INFO - mozversion application_changeset: 9f871c40b36f164a3413c5aea5c4434f080a7bf0 18:52:12 INFO - mozversion application_display_name: Nightly 18:52:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:52:12 INFO - mozversion application_name: Firefox 18:52:12 INFO - mozversion application_remotingname: firefox 18:52:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:52:12 INFO - mozversion application_vendor: Mozilla 18:52:12 INFO - mozversion application_version: 54.0a1 18:52:12 INFO - mozversion platform_buildid: 20170221173528 18:52:12 INFO - mozversion platform_changeset: 9f871c40b36f164a3413c5aea5c4434f080a7bf0 18:52:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:52:12 INFO - mozversion platform_version: 54.0a1 18:52:12 INFO - using testdate: 1487731932 18:52:12 INFO - actual date: 1487731932 18:52:12 INFO - starting webserver on 'localhost:49242' 18:52:12 INFO - SUITE-START | Running 2 tests 18:52:12 INFO - TEST-START | dromaeo_css 18:52:12 INFO - operating with platform_type : mac_ 18:52:12 INFO - Initialising browser for dromaeo_css test... 18:52:12 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpb_wLPC/profile http://localhost:49242/getInfo.html) 18:52:14 INFO - PROCESS | 1645 | __metrics Screen width/height:1600/1200 18:52:14 INFO - PROCESS | 1645 | colorDepth:24 18:52:14 INFO - PROCESS | 1645 | Browser inner width/height: 1024/689 18:52:14 INFO - PROCESS | 1645 | __metrics 18:52:15 INFO - PROCESS | 1645 | 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" 18:52:15 INFO - PROCESS | 1645 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:52:15 INFO - TEST-INFO | 1645: exit 0 18:52:15 INFO - Browser initialized. 18:52:15 INFO - Running cycle 1/1 for dromaeo_css test... 18:52:15 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpb_wLPC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:52:27 INFO - PROCESS | 1648 | RSS: Main: 231579648 18:52:27 INFO - PROCESS | 1648 | 18:55:31 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 18:55:33 INFO - PROCESS | 1648 | RSS: Main: 418611200 18:55:33 INFO - PROCESS | 1648 | 18:57:17 INFO - PROCESS | 1648 | ************************* 18:57:17 INFO - PROCESS | 1648 | A coding exception was thrown and uncaught in a Task. 18:57:17 INFO - PROCESS | 1648 | 18:57:17 ERROR - PROCESS | 1648 | Full message: TypeError: NetworkError when attempting to fetch resource. 18:57:17 INFO - PROCESS | 1648 | Full stack: 18:57:17 INFO - PROCESS | 1648 | ************************* 18:58:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 18:58:37 INFO - PROCESS | 1648 | RSS: Main: 389599232 18:58:37 INFO - PROCESS | 1648 | 19:01:40 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 19:01:41 INFO - PROCESS | 1648 | RSS: Main: 342200320 19:01:41 INFO - PROCESS | 1648 | 19:04:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 19:04:44 INFO - PROCESS | 1648 | RSS: Main: 351043584 19:04:44 INFO - PROCESS | 1648 | 19:07:47 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 19:07:48 INFO - PROCESS | 1648 | RSS: Main: 338513920 19:07:48 INFO - PROCESS | 1648 | 19:10:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 19:10:52 INFO - PROCESS | 1648 | RSS: Main: 512131072 19:10:52 INFO - PROCESS | 1648 | 19:10:52 INFO - PROCESS | 1648 | __start_tp_report 19:10:52 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 19:10:52 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 19:10:52 INFO - PROCESS | 1648 | |i|pagename|runs| 19:10:52 INFO - PROCESS | 1648 | |0;dojo.html;3281.6226133994596;3295.093849191472;3314.999999999999;3326.434506133957;3361.5461912641786;5462.399136095027;5563.833085007446;5611.018071837428;5658.43415658434;5714.828555143342;5472;5533;5533.750981205845;5535.944640553604;5558.916616250759;5041.521055499722;5062.797488100471;5090.567301779353;5132.486751324856;5143.09995750744;5123.897522049557;5193.948060519403;5196.038732834438;5209.062368773619;5215.843524694246;5159.974200128994;5169.974150129263;5171.198464238049;5175.637705360627;5179.8446046618665;5159.509846564608;5175.120229560965;5175.301334319856;5182.481751824825;5185.611079169059;4982.202847544412;5126.359205099363;5128.948710512885;5130.563902068328;5136.614753893473;5655.321361436613;5777.855553611152;5786.797462088849;5791.971040144772;5799.826005219808;6141.754329826802;6172.012478003543;6182.969085154546;6184.474319682832;6209.068639704081;6074.969625151846;6102.45895535354;6158.860610787019;6159.5072394208355;6167.167432396659;4164.250434921712;5690.146478028288;5712.0860662293835;5731.742071606787;5735.139729040636;6109.938900611026;6148.6925653717135;6159.907601385983;6162.907556386658;6172.043333283348;6007.219061521974;6014.48876845473;6024.096385542204;6029.065494848305;6043;6048.848778780566;6102.603330783485;6105.163806164722;6106.4809491192855;6144.692765361714;6146.262448506119;6173.660448675366;6178.382161783876;6180.258368995749;6184.103305020747;6139.84650383744;6163.414475624809;6184.474319682788;6191.9690401547705;6195.81412557624;4769.689970151929;4811.975940120277;4863.392075990501;4873.049755297754;4928.211486162197;4364.8254069837485;4426.380306757057;4431.7340959542535;4436.223660859337;4438.533953934791;5686.061799803069;5695.658260504383;5698.00284950132;5702.885942281131;5704.942950570441;6187.3503282155625;6220.844478888064;6227.719752611143;6238.968805155945;6241.531885108635;5521.558275338044;5572.3870374258795;5581.776728930798;5609.971950140223;5617.522510586646;5275.841724748264;5289.18017707256;5295.761690723926;5317.760700768475;5317.973410132925;6230.59501132434;6231.3145553988115;6245.219347581552;6249.468795152463;6255.186825712719;6114.449440885012;6128.961487065963;6135.2326666699655;6138.541671868701;6142.7136481981925;6206.782762603287;6212.347703491249;6213.130161777264;6234.844128896814;6244.875102498016;6144.771045790771;6153.600015998945;6163.19878415803;6168.691565421801;6174.629522228681;6039.335673075871;6192;6225.128482012431;6236.126942228182;6259.561830671809;5811;5859.2382990211;5867.031939730067;5941.989861723604;6054.424829641177;5864.179014937827;5876.706164691663;5877;5878;5883.2057672213705;5613.214150018919;5723.112917497794;5732.799352022659;5827.475527202572;5878.382769809108;6071.5446341523675;6078.665673388006;6078.848028799315;6109.938900610937;6112.602680825732;5898.056310990221;5900.527957763283;5902.20320256777;5904.763809447574;5918.3489816121055 19:10:52 INFO - PROCESS | 1648 | |1;ext.html;443.0761861518735;479.7121726963821;492.13630079210986;512.8256392826438;519.5869283919284;28154.436911261764;28578.714212857893;40440;42569.574304257025;42681.57318426815;41332.760017199456;43456.348154777625;43559;43563.128737425235;43691.3446298305;9482.383645063066;9716.611335546604;9720.805583888354;9723.805523889518;9727.562259698296;7524.360429363511;7743.961280193591;9478.763030924247;11473.713157171096;11823.231489953168;10724.981126792942;10992.03215131914;11697.649070527856;11699.766004679901;11713.1215158863;11677.948984591385;11737.237079589799;11737.647870563897;11743.11926605508;11745.060395168366;7527.284907933792;7744.380449564022;7744.922550774477;7794.41541884361;11529.308241505452;32863.6713632863;34817.6518234817;40487.19025619471;41529.37705934414;42572.57427425717;3787.5265591801026;3792.943105853414;3802.657760801541;3850.557185923599;3960.980195099035;29859.70140298591;29958;29974;31113.222169445944;31248.906288279803;3124.4376012317775;3136.200268931431;3147.5278708193723;3150.5431712401573;3155.984220078908;328653.7134628647;329646;329877.3506132478;329964;333547;49523.50476495189;60593.09110363348;60922;60925;60972.390276096674;71935.6403217991;72183;73769;73980.63009684917;74983.25016749871;11698.654654714817;12720.173188742701;13136.60590182296;13429.865701342862;13452.596422107352;10332.431716255527;11590.594329198437;11735.823962640567;11840.881591183977;11950.88049119515;19786.767168341925;20284.188632454538;20313.89843050805;20314.59370812605;20345.422279987182;8071.515709057476;8178;8191.3787587972465;8191.426600138052;8252.298554622925;839.8950131233596;844.50174397106;850.7150104714866;861.7500924731883;868.3357231717741;28892.42215155685;29358.26604334866;29507.91962057423;29934;30796.846015769777;1025.9743506412399;1032.5611615063717;1055.7782865598156;1065.2543219746208;1167.9474423650956;14415.711685766226;14581.781273280909;15462.301932787832;15684.624712316472;15749.370025199092;596345;604660;605371;606231;606855.9657201774;58855.70572147112;59334.40665593375;59394;59477;59633;1343.6237853401062;1396.5839098359895;1396.860313968595;1396.9930150349182;1401.9299035048207;26786.062487812833;27007.86496067507;28564;28612.713872861004;29193.85403072971;50198.99602008012;50645;50655.746721267635;50763.98472030613;50773.74613126911;473077;495995;498791;499379;499625.5018724883;30318.69681303247;31845.20386990344;40267.798661006505;40303.59696402998;41174.58825411707;38050.80974595109;44599.77700111608;45217.54782452133;46433.53566464292;46485.3027204599;33166.67881349719;34924.65075349214;36767.63232367642;37763.05592360103;38062.42906356351;36365.63634363622;37186.62813371832;37618.623813761515;37849.4322585156;38001;36203.45694814527;36645.45031824578;37497.87506374813;37542.624573753914;37668.81165594154;29157.7084229155;32559.18602034968;32798.01605951825;32827.67172328246;33122.83438582792;22201.888990554944;23743.643845342678;23752.168674097014;24351.391215219763;24919.626205606568 19:10:52 INFO - PROCESS | 1648 | |2;jquery.html;351.7906845426971;361.37121408748783;384.45983393332375;394.65073410032113;425.7679564637272;13776.517821876236;14381.568552943416;17807.376741814038;19899.204031838726;21331.25340613079;20537.589248215063;20970.475738106554;21143.894280528613;21158.788412115875;21343.25298614549;5875.529957603381;6086.087086936973;6136.7545298188015;6153.261608606974;6154.230721159855;5140.2546630738525;5777.797777077803;5990.640561566298;6058.697065146747;6060.181875446802;6017.8194654160225;6021.819345419644;6026.758929642831;6029.758809647609;6044.818655440344;5753.798617048405;5946.375630558816;6014.789482368096;6016.75932962681;6019.458248757589;5150.562202212816;5200.063988482072;5222.97388513055;5223.52988231061;5227.60792940531;25025.49949001028;25282.620760688606;25335.873320633462;25619.487610247692;25720.356991075187;2637.7626013658864;2662.587298968663;2667.0931883159624;2678.317029157572;2700.486907487571;9861.753456163582;10125.443100629462;10343.224258180666;12341.950934170516;14085.225312607905;1794.97307540387;1814.2561549764664;1839.8620103492292;1851.4260579220486;1885.641728071662;122915;123617.76382236242;128084;131691.34154329263;148250.99999999892;10475.528601212964;11331.886681133083;11465.942670286762;11590.76818463626;11807.940960295315;13707.246101464316;14100;14128.222947737973;14750.852491475163;14757.852421475862;8083;8194.672213111528;8214.8357032859;8223.629936652866;8325.417220794487;7025.367716905503;7091.964540177266;7802.761853830597;7976.242256985577;7990.520568765893;4590.816367345269;4636.5131661175765;4650.837220697259;4727.881802954954;4800;1721.9741703874452;1974.2004488182308;2018.3238615064117;2023.4233243525525;2032.156654988193;822.1860358245294;995.9701208963743;1005.3264312910368;1011.7723512209694;1041.4584416103585;20393;20417.97910104489;20443.79556204419;20454.284100056426;20472.18111275562;946.2524605561667;1009.8990100989843;1015.7714514234239;1053.510117795229;1055.3562326980536;9883.604655813688;10152.796944061078;10546.998035186645;10585.947070264754;10654.094401975764;535510;538706;541839;672846;705679;115400;122668;146166;152597.71103433458;156975.21512392364;1008.8461135475812;1032.4837581209395;1066.9519871605796;1069.9625513107003;1071.3946620159586;18484.353047643268;18687;18990.24039038478;19042;19427.320043798398;46502;56783.71608141933;57718.13422798577;58925;59731;84029.57985210035;84677;85679;86241;87497.1250287489;7967.2431119043595;8019.518828870287;8083.514989100673;8171.142030086755;8238.176182381714;10864.565417383215;12145;12291.877081229073;12518.248905065726;12525.248485090924;10305.072543471124;10524.00021997909;10568.365898046142;10834.945825270823;10896;10370.066693997576;10448.477576121011;10630.202734794766;10842.728931776768;10902.509387077442;10727.946360268148;10796.244262901522;11063.50214240345;11080.944595276973;11181.32912025281;6646;8073.609084184774;8204.138565450541;8440.366972476966;8448.493090414595;10501.684949451528;10538.525766340686;10784.89215107839;10803.945980270048;10838 19:10:52 INFO - PROCESS | 1648 | |3;mootools.html;1419.7302512522622;1446.6238777917745;1465.2161093814798;1466.9339879705406;1488.1591900576177;8009.759707208786;8462.280706139978;8462.449940753846;8467.195616416446;8468.280196183325;8097.959510202455;8372.413931024816;8382.748517544469;8473.237408633222;8486.575671216446;2012.0040579912963;2118.8304935605115;2148.892555372233;2238.664200369941;2316;2297.632378819389;2319.3042087373806;2331.3006098170567;2332.9236979088623;2336.100601268515;2268.4895898422888;2287.313805858244;2306.3888069661552;2307.4231442139467;2308.076769292288;2277.567262220181;2287.759785222561;2296.3570200343847;2301.838871279011;2304.2626359564947;2269.6708977198377;2292.289390289016;2317.8261630377788;2323.8373313868037;2325.453518423169;8420.28427583656;8486.74539763808;8496.915030849674;8497.362697797627;8513.787155321104;5030.849074527733;5184.922226166611;5197.7920883164625;5206.323177986837;5209.817656382009;3272.378248132847;3323.667633236681;3487.546618939547;3555.7866528008144;3573.3210689968823;1167.5913430299413;1215.3376409856648;1223.5044806853239;1239.9752004959942;1253.5988483685223;9993.300468967103;10263.178945684327;10298.999999999925;10701.304415212986;10754.623588174376;4081.836726530965;4185.811638476276;4186.916261674811;4188.643965262926;4199.181159673895;8621.31029517637;8742.994555626057;8756.430831996027;8831.823363532694;8847.46915185091;4961.933184365379;5038.042771873333;5040.521150490697;5043.5460808527405;5051.898962020739;4582.495925448198;4700.741459219707;4736.573708366263;4786.2581299898575;4823.710577365369;3055.220918665726;3493.8951831445097;3623.7463377563845;3664.3953747631344;3666.505021822073;894.9955250223837;1018.5009345420839;1019.6635110413546;1022.1532635043709;1033.6898930320874;691.695653912277;755.7354925775934;760.7755712064954;788.4402074527035;824.2787560884226;5292.444293349143;5340.465953404629;5422.783088676409;5537.667739935617;5624.803131890364;545.4490964126181;546.5572885962383;578.9768409263582;586.3637952821236;592.3957563285425;2976.538636511344;3605.20685449206;3644.3053979899473;3710.350688629479;3755.117547376364;8618.482891026559;8889.111088891188;8999.415038022507;9799.608015679292;9913.55389007482;9700.757481062888;9840.966698496697;9856.845809341085;9857.35927164732;9857.753556161153;7625.6568454419685;7735.806604834924;7751.108622508484;7757.418193635387;7780.14418413974;5180.870478238075;5428.158635411518;5485.725713714219;5493.450654934474;5495.505404513613;8892.199702026848;8935.553222338727;9039.276857851488;9107.954460227656;9183.403078799856;7021.648917554204;9228.584713687766;9286.34995550305;9325.347225694137;9334.113259240361;6130.47890929276;6674.532782705358;6749.392554670103;6765.154355705537;6775.695093720893;7162.534435261691;7241.746538871114;7917.327027202752;7982.6008699565955;8059.5164290142775;7022.754203602849;7091.184513780981;7100.964495177491;7197.928020719935;7268.127824661075;6950.131233595801;6965.199002114619;6969.4424446045205;7036;7053.294670532906;5968.701564921824;6167.660778657217;6228.688565571794;6261.342559031418;6306.369363063657;4839.951600484091;4863.440704319049;4868.537488938545;4899.280899100891;5043.798248070036;4295.72077814941;4358.716683415568;4995.675281106716;5005.724685142207;5057.620678449058 19:10:52 INFO - PROCESS | 1648 | |4;prototype.html;349.5665374935081;356.2198784661591;364.5315769236532;367.5662717992771;371.72863809419124;4601;5097.59219262459;5107.131787596109;5109.105906466363;5147.562457191134;4370.431843860301;4745.240761478164;4809.687370320927;4876.756162191894;5031.660277970743;3416.829158542075;3809.1810260793923;3887.669548088402;3912.804359782021;3927.70542209334;3325.9501107483406;3668.578113516953;3774.830132644038;3823.847046118152;3933.9213215735667;3729.533808273966;3818.503594532721;3904.882853514385;3910.198409326081;3919.98040009801;3336.7664263501565;3844.596317386676;3867.5165604299464;3909.4135879618;3912.510936132969;3349.5478110455265;3354.194993201638;3354.3794398036443;3358.177246574605;3372.392969265531;4703.858884233478;4754.904901901942;4963.726995015273;4977.651564390494;4985.401751789772;3871.4967054283043;3984.8282685935947;4245.8513952011845;4432.874823249601;4462.594282800907;5372.865678358073;5389.703566303851;5390.00284947286;5392.676439413648;5404.270423492818;3693.9287606594057;3703.3889408247605;3735.6077611850906;3741.7754934704003;3741.9625803741887;4723.625240093929;5248.501392367719;5350.34139416782;5574.470425309589;5651.350094739117;3188.744900408008;3432.7597068204986;3463.9826800865835;3602.5857026442295;3735.43968404736;3675.8162091895297;3776.999095239764;3780.697544196458;3783.770274660746;3819.923601527954;4388.012697143181;4388.451443569554;4390.487609912057;4399.21831658179;4414.911701765946;4644.767761611906;4800.783964721596;4969.676970996874;5232;5428.9185662215095;1129.4014172488594;1168.0772189969998;1217.3608855351013;1247.6880779805049;1248.7003119251315;723.9384652304508;831.193742070191;843.9071702112763;848.1857416879865;850.3036442297656;4679.43239014927;4832.487106704494;4853.611711063107;4853.975730121327;4855.295982082649;4151.481064866892;4261.552536983634;4980.352554167935;5149.031184906583;5287.550558202519;4282.828686852553;4581.9690569622235;4841.975790121027;4863.683860549124;4884.898089712987;2487.743689436859;2760.5997130415976;2775.680796708364;2787.567926971323;2788.024191532947;5117.136561895745;5207.791688332424;5446.618736688473;5454.318210223722;5531.474509921551;4885.242787367893;4943.555080042814;5196.844094677166;5281.524662780368;5403.702796346239;5259.342582177228;5629.746661400165;5670.801521946877;5671.461211184931;5698.230738850285;4399.560043995575;5325.434920508156;5492.835214943558;5525.972370138124;5599.636023658449;4913.901721965469;5115.641905066758;5413.918791218213;5473.713677285755;5484.725763711878;4967.031428871335;5328.440513746156;5675.772969081356;5681.403452637579;5690.544756419394;3251.9837400812844;3497.772644778183;3557.5019497269886;3717.386631205821;3729.664330210294;4969.801207951786;5110.872228194325;5240.397354304304;5266.786570743467;5541.362743284574;4933.383327084114;4961.404631444249;5358.169483730028;5383.946160538501;5386.8383948481605;4786.7845946931775;5135.306733591066;5194.922076168936;5367.570594352364;5383.461653834585;4894.608431325414;4953.356063711839;4986.526280003394;5259.4477579853565;5262.526372626482;4723.811047558059;5080.339555857715;5355.3305836770405;5358.767483478744;5380.43505431924;4162.917641413315;4976;5139.434662187082;5225.399079105951;5278.36659600835 19:10:52 INFO - PROCESS | 1648 | |5;yui.html;709.1986055756994;716.5306724095716;754.5005512897213;757.9048275242276;816.1919699497497;14548.56354309371;14563.27183640819;14967.625809354786;15070;15215.315310811013;10817.729556761085;12494.687632809184;12516.624501264954;12613.810792838092;12636;878.9560521973908;915.3226612306895;921.6543796076471;926.9443833369986;932.0632764072099;904.7602385367883;926.1942110363992;928.3501548915752;930.6137952749601;936.1574582875432;817.6606708216113;965.7971825916566;968.7868668892833;969.6945462179426;971.4171497101753;967.5984466446416;967.709687093869;967.8741763570725;968.4963818814177;968.840141376672;727.3126895084148;728.1226122522348;728.4209053802186;728.5118970289918;729.1104852080454;15022.94839361245;15196;15362.692746145127;15618.984765990173;15681.294341754648;13460.932695336558;13750.65623359414;13955.79066314006;14258.64353391163;14384.424623015067;10762.139028877671;11099.55601775928;11179.60871369498;11587.188896777228;12126.454309556002;4020.3768415895584;4398.53415479245;4413.6910416270875;4476.709013914117;4607.17070927233;90210;103023;104192.39519012009;106470;108165.31602917533;9183.816323673624;10558.788824223473;10633.096186824207;10790;10955.233133680566;19556.21775128979;20435.284765033153;21023.78976210249;21450.57098858014;21481.140754369964;7238.167610724834;7338.559686418832;7358.043454351007;7385.8153546161775;7528.887066694004;4000.2599519089063;4082.101937573729;4085.264652362603;4089.1821635672986;4089.5297040840087;3483.5819701635965;3575.6245594212232;3611.9277614447565;3615.222727113683;3624.9637503624626;656.7569999100364;662.9502787290972;664.4485077385758;679.6941376380648;686.4439803758971;511.3148381169251;512.6206607110711;515.7704821354462;529.875479262373;557.0140850694329;8477.27943124829;8879.733607991771;8894.73315800527;9431.76420589477;9579.13787759091;641.2241188162376;648.4552975500602;659.8053574195528;665.3679004945321;669.3540733192492;4261.01837843198;4351.97824010878;4547.431571053618;4551.977240113844;4565.429321334833;89050;89756.5512172435;90066.54966725255;90778.54610726904;91950;78593;80114.5994270025;81619.5919020401;91411.54294228487;94338;69297.30702692909;69947.65026174938;70995.64502177559;75095;75356;10527;10531.420771857314;10560.947195263974;10737.838932416176;10807.729806754895;39937.600623993385;42569;47359.76320118377;48662.5133748658;50795.74602126966;63756.68121659362;64067.35932640614;65484.017739734896;65679.34320656733;66094.33905660882;12955.481780728665;13009.154404963647;13116.803247951479;13295.335233238493;13414.932925335701;14281.071730337495;14339.426422942965;14485.51001853154;14501.347439365465;14512.927435362755;13204.80192797128;13518.25649589282;13562.525311614441;13723.725525489634;13778.448862045407;13276.336183190995;13360.86639133635;13379;13425.462981480632;13705.177689338672;13374.531891383755;13424.127431716906;13428;13659.795103073264;13808.516701915385;9212.263018958602;10394.740131496774;10741.140708743438;10834.065230659315;11114.777704446027;9210.585523651585;9415.340926135104;10630.574777008833;10636;10650 19:10:52 INFO - PROCESS | 1648 | __end_tp_report 19:10:52 INFO - PROCESS | 1648 | __start_cc_report 19:10:52 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2003 19:10:52 INFO - PROCESS | 1648 | __end_cc_report 19:10:52 INFO - PROCESS | 1648 | __startTimestamp1487733052353__endTimestamp 19:10:52 INFO - PROCESS | 1648 | 19:10:52 INFO - PROCESS | 1648 | ------- Summary: start ------- 19:10:52 INFO - PROCESS | 1648 | Number of tests: 6 19:10:52 INFO - PROCESS | 1648 | 19:10:52 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5661.45 Median:5867.03 stddev:638.38 (10.9%) stddev-sans-first:612.44 19:10:52 INFO - PROCESS | 1648 | Values: 3281.6 3295.1 3315.0 3326.4 3361.5 5462.4 5563.8 5611.0 5658.4 5714.8 5472.0 5533.0 5533.8 5535.9 5558.9 5041.5 5062.8 5090.6 5132.5 5143.1 5123.9 5193.9 5196.0 5209.1 5215.8 5160.0 5170.0 5171.2 5175.6 5179.8 5159.5 5175.1 5175.3 5182.5 5185.6 4982.2 5126.4 5128.9 5130.6 5136.6 5655.3 5777.9 5786.8 5792.0 5799.8 6141.8 6172.0 6183.0 6184.5 6209.1 6075.0 6102.5 6158.9 6159.5 6167.2 4164.3 5690.1 5712.1 5731.7 5735.1 6109.9 6148.7 6159.9 6162.9 6172.0 6007.2 6014.5 6024.1 6029.1 6043.0 6048.8 6102.6 6105.2 6106.5 6144.7 6146.3 6173.7 6178.4 6180.3 6184.1 6139.8 6163.4 6184.5 6192.0 6195.8 4769.7 4812.0 4863.4 4873.0 4928.2 4364.8 4426.4 4431.7 4436.2 4438.5 5686.1 5695.7 5698.0 5702.9 5704.9 6187.4 6220.8 6227.7 6239.0 6241.5 5521.6 5572.4 5581.8 5610.0 5617.5 5275.8 5289.2 5295.8 5317.8 5318.0 6230.6 6231.3 6245.2 6249.5 6255.2 6114.4 6129.0 6135.2 6138.5 6142.7 6206.8 6212.3 6213.1 6234.8 6244.9 6144.8 6153.6 6163.2 6168.7 6174.6 6039.3 6192.0 6225.1 6236.1 6259.6 5811.0 5859.2 5867.0 5942.0 6054.4 5864.2 5876.7 5877.0 5878.0 5883.2 5613.2 5723.1 5732.8 5827.5 5878.4 6071.5 6078.7 6078.8 6109.9 6112.6 5898.1 5900.5 5902.2 5904.8 5918.3 19:10:52 INFO - PROCESS | 1648 | 19:10:52 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:62577.11 Median:37342.25 stddev:130448.89 (349.3%) stddev-sans-first:130731.42 19:10:52 INFO - PROCESS | 1648 | Values: 443.1 479.7 492.1 512.8 519.6 28154.4 28578.7 40440.0 42569.6 42681.6 41332.8 43456.3 43559.0 43563.1 43691.3 9482.4 9716.6 9720.8 9723.8 9727.6 7524.4 7744.0 9478.8 11473.7 11823.2 10725.0 10992.0 11697.6 11699.8 11713.1 11677.9 11737.2 11737.6 11743.1 11745.1 7527.3 7744.4 7744.9 7794.4 11529.3 32863.7 34817.7 40487.2 41529.4 42572.6 3787.5 3792.9 3802.7 3850.6 3961.0 29859.7 29958.0 29974.0 31113.2 31248.9 3124.4 3136.2 3147.5 3150.5 3156.0 328653.7 329646.0 329877.4 329964.0 333547.0 49523.5 60593.1 60922.0 60925.0 60972.4 71935.6 72183.0 73769.0 73980.6 74983.3 11698.7 12720.2 13136.6 13429.9 13452.6 10332.4 11590.6 11735.8 11840.9 11950.9 19786.8 20284.2 20313.9 20314.6 20345.4 8071.5 8178.0 8191.4 8191.4 8252.3 839.9 844.5 850.7 861.8 868.3 28892.4 29358.3 29507.9 29934.0 30796.8 1026.0 1032.6 1055.8 1065.3 1167.9 14415.7 14581.8 15462.3 15684.6 15749.4 596345.0 604660.0 605371.0 606231.0 606856.0 58855.7 59334.4 59394.0 59477.0 59633.0 1343.6 1396.6 1396.9 1397.0 1401.9 26786.1 27007.9 28564.0 28612.7 29193.9 50199.0 50645.0 50655.7 50764.0 50773.7 473077.0 495995.0 498791.0 499379.0 499625.5 30318.7 31845.2 40267.8 40303.6 41174.6 38050.8 44599.8 45217.5 46433.5 46485.3 33166.7 34924.7 36767.6 37763.1 38062.4 36365.6 37186.6 37618.6 37849.4 38001.0 36203.5 36645.5 37497.9 37542.6 37668.8 29157.7 32559.2 32798.0 32827.7 33122.8 22201.9 23743.6 23752.2 24351.4 24919.6 19:10:52 INFO - PROCESS | 1648 | 19:10:52 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:35866.45 Median:21057.19 stddev:101524.88 (482.1%) stddev-sans-first:101774.66 19:10:52 INFO - PROCESS | 1648 | Values: 351.8 361.4 384.5 394.7 425.8 13776.5 14381.6 17807.4 19899.2 21331.3 20537.6 20970.5 21143.9 21158.8 21343.3 5875.5 6086.1 6136.8 6153.3 6154.2 5140.3 5777.8 5990.6 6058.7 6060.2 6017.8 6021.8 6026.8 6029.8 6044.8 5753.8 5946.4 6014.8 6016.8 6019.5 5150.6 5200.1 5223.0 5223.5 5227.6 25025.5 25282.6 25335.9 25619.5 25720.4 2637.8 2662.6 2667.1 2678.3 2700.5 9861.8 10125.4 10343.2 12342.0 14085.2 1795.0 1814.3 1839.9 1851.4 1885.6 122915.0 123617.8 128084.0 131691.3 148251.0 10475.5 11331.9 11465.9 11590.8 11807.9 13707.2 14100.0 14128.2 14750.9 14757.9 8083.0 8194.7 8214.8 8223.6 8325.4 7025.4 7092.0 7802.8 7976.2 7990.5 4590.8 4636.5 4650.8 4727.9 4800.0 1722.0 1974.2 2018.3 2023.4 2032.2 822.2 996.0 1005.3 1011.8 1041.5 20393.0 20418.0 20443.8 20454.3 20472.2 946.3 1009.9 1015.8 1053.5 1055.4 9883.6 10152.8 10547.0 10585.9 10654.1 535510.0 538706.0 541839.0 672846.0 705679.0 115400.0 122668.0 146166.0 152597.7 156975.2 1008.8 1032.5 1067.0 1070.0 1071.4 18484.4 18687.0 18990.2 19042.0 19427.3 46502.0 56783.7 57718.1 58925.0 59731.0 84029.6 84677.0 85679.0 86241.0 87497.1 7967.2 8019.5 8083.5 8171.1 8238.2 10864.6 12145.0 12291.9 12518.2 12525.2 10305.1 10524.0 10568.4 10834.9 10896.0 10370.1 10448.5 10630.2 10842.7 10902.5 10727.9 10796.2 11063.5 11080.9 11181.3 6646.0 8073.6 8204.1 8440.4 8448.5 10501.7 10538.5 10784.9 10803.9 10838.0 19:10:52 INFO - PROCESS | 1648 | 19:10:52 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5281.35 Median:5381.62 stddev:2904.98 (54.0%) stddev-sans-first:2898.64 19:10:52 INFO - PROCESS | 1648 | Values: 1419.7 1446.6 1465.2 1466.9 1488.2 8009.8 8462.3 8462.4 8467.2 8468.3 8098.0 8372.4 8382.7 8473.2 8486.6 2012.0 2118.8 2148.9 2238.7 2316.0 2297.6 2319.3 2331.3 2332.9 2336.1 2268.5 2287.3 2306.4 2307.4 2308.1 2277.6 2287.8 2296.4 2301.8 2304.3 2269.7 2292.3 2317.8 2323.8 2325.5 8420.3 8486.7 8496.9 8497.4 8513.8 5030.8 5184.9 5197.8 5206.3 5209.8 3272.4 3323.7 3487.5 3555.8 3573.3 1167.6 1215.3 1223.5 1240.0 1253.6 9993.3 10263.2 10299.0 10701.3 10754.6 4081.8 4185.8 4186.9 4188.6 4199.2 8621.3 8743.0 8756.4 8831.8 8847.5 4961.9 5038.0 5040.5 5043.5 5051.9 4582.5 4700.7 4736.6 4786.3 4823.7 3055.2 3493.9 3623.7 3664.4 3666.5 895.0 1018.5 1019.7 1022.2 1033.7 691.7 755.7 760.8 788.4 824.3 5292.4 5340.5 5422.8 5537.7 5624.8 545.4 546.6 579.0 586.4 592.4 2976.5 3605.2 3644.3 3710.4 3755.1 8618.5 8889.1 8999.4 9799.6 9913.6 9700.8 9841.0 9856.8 9857.4 9857.8 7625.7 7735.8 7751.1 7757.4 7780.1 5180.9 5428.2 5485.7 5493.5 5495.5 8892.2 8935.6 9039.3 9108.0 9183.4 7021.6 9228.6 9286.3 9325.3 9334.1 6130.5 6674.5 6749.4 6765.2 6775.7 7162.5 7241.7 7917.3 7982.6 8059.5 7022.8 7091.2 7101.0 7197.9 7268.1 6950.1 6965.2 6969.4 7036.0 7053.3 5968.7 6167.7 6228.7 6261.3 6306.4 4840.0 4863.4 4868.5 4899.3 5043.8 4295.7 4358.7 4995.7 5005.7 5057.6 19:10:52 INFO - PROCESS | 1648 | 19:10:52 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4285.07 Median:4853.79 stddev:1300.83 (26.8%) stddev-sans-first:1270.50 19:10:52 INFO - PROCESS | 1648 | Values: 349.6 356.2 364.5 367.6 371.7 4601.0 5097.6 5107.1 5109.1 5147.6 4370.4 4745.2 4809.7 4876.8 5031.7 3416.8 3809.2 3887.7 3912.8 3927.7 3326.0 3668.6 3774.8 3823.8 3933.9 3729.5 3818.5 3904.9 3910.2 3920.0 3336.8 3844.6 3867.5 3909.4 3912.5 3349.5 3354.2 3354.4 3358.2 3372.4 4703.9 4754.9 4963.7 4977.7 4985.4 3871.5 3984.8 4245.9 4432.9 4462.6 5372.9 5389.7 5390.0 5392.7 5404.3 3693.9 3703.4 3735.6 3741.8 3742.0 4723.6 5248.5 5350.3 5574.5 5651.4 3188.7 3432.8 3464.0 3602.6 3735.4 3675.8 3777.0 3780.7 3783.8 3819.9 4388.0 4388.5 4390.5 4399.2 4414.9 4644.8 4800.8 4969.7 5232.0 5428.9 1129.4 1168.1 1217.4 1247.7 1248.7 723.9 831.2 843.9 848.2 850.3 4679.4 4832.5 4853.6 4854.0 4855.3 4151.5 4261.6 4980.4 5149.0 5287.6 4282.8 4582.0 4842.0 4863.7 4884.9 2487.7 2760.6 2775.7 2787.6 2788.0 5117.1 5207.8 5446.6 5454.3 5531.5 4885.2 4943.6 5196.8 5281.5 5403.7 5259.3 5629.7 5670.8 5671.5 5698.2 4399.6 5325.4 5492.8 5526.0 5599.6 4913.9 5115.6 5413.9 5473.7 5484.7 4967.0 5328.4 5675.8 5681.4 5690.5 3252.0 3497.8 3557.5 3717.4 3729.7 4969.8 5110.9 5240.4 5266.8 5541.4 4933.4 4961.4 5358.2 5383.9 5386.8 4786.8 5135.3 5194.9 5367.6 5383.5 4894.6 4953.4 4986.5 5259.4 5262.5 4723.8 5080.3 5355.3 5358.8 5380.4 4162.9 4976.0 5139.4 5225.4 5278.4 19:10:52 INFO - PROCESS | 1648 | 19:10:52 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:19423.88 Median:4406.11 stddev:27413.78 (622.2%) stddev-sans-first:27454.67 19:10:52 INFO - PROCESS | 1648 | Values: 709.2 716.5 754.5 757.9 816.2 14548.6 14563.3 14967.6 15070.0 15215.3 10817.7 12494.7 12516.6 12613.8 12636.0 879.0 915.3 921.7 926.9 932.1 904.8 926.2 928.4 930.6 936.2 817.7 965.8 968.8 969.7 971.4 967.6 967.7 967.9 968.5 968.8 727.3 728.1 728.4 728.5 729.1 15022.9 15196.0 15362.7 15619.0 15681.3 13460.9 13750.7 13955.8 14258.6 14384.4 10762.1 11099.6 11179.6 11587.2 12126.5 4020.4 4398.5 4413.7 4476.7 4607.2 90210.0 103023.0 104192.4 106470.0 108165.3 9183.8 10558.8 10633.1 10790.0 10955.2 19556.2 20435.3 21023.8 21450.6 21481.1 7238.2 7338.6 7358.0 7385.8 7528.9 4000.3 4082.1 4085.3 4089.2 4089.5 3483.6 3575.6 3611.9 3615.2 3625.0 656.8 663.0 664.4 679.7 686.4 511.3 512.6 515.8 529.9 557.0 8477.3 8879.7 8894.7 9431.8 9579.1 641.2 648.5 659.8 665.4 669.4 4261.0 4352.0 4547.4 4552.0 4565.4 89050.0 89756.6 90066.5 90778.5 91950.0 78593.0 80114.6 81619.6 91411.5 94338.0 69297.3 69947.7 70995.6 75095.0 75356.0 10527.0 10531.4 10560.9 10737.8 10807.7 39937.6 42569.0 47359.8 48662.5 50795.7 63756.7 64067.4 65484.0 65679.3 66094.3 12955.5 13009.2 13116.8 13295.3 13414.9 14281.1 14339.4 14485.5 14501.3 14512.9 13204.8 13518.3 13562.5 13723.7 13778.4 13276.3 13360.9 13379.0 13425.5 13705.2 13374.5 13424.1 13428.0 13659.8 13808.5 9212.3 10394.7 10741.1 10834.1 11114.8 9210.6 9415.3 10630.6 10636.0 10650.0 19:10:52 INFO - PROCESS | 1648 | -------- Summary: end -------- 19:10:52 INFO - PROCESS | 1648 | 19:10:53 INFO - TEST-INFO | 1648: exit 0 19:10:53 INFO - TEST-OK | dromaeo_css | took 1120947ms 19:10:53 INFO - TEST-START | kraken 19:10:53 INFO - operating with platform_type : mac_ 19:10:53 INFO - Initialising browser for kraken test... 19:10:53 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpUcUmd1/profile http://localhost:49242/getInfo.html) 19:10:55 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 19:10:55 INFO - PROCESS | 1658 | colorDepth:24 19:10:55 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 19:10:55 INFO - PROCESS | 1658 | __metrics 19:10:55 INFO - PROCESS | 1658 | 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" 19:10:55 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 19:10:56 INFO - TEST-INFO | 1658: exit 0 19:10:56 INFO - Browser initialized. 19:10:56 INFO - Running cycle 1/1 for kraken test... 19:10:56 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/97/rkh_tff557l6vj3yx2fd921000000w/T/tmpUcUmd1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:11:08 INFO - PROCESS | 1659 | RSS: Main: 231415808 19:11:08 INFO - PROCESS | 1659 | 19:11:11 INFO - PROCESS | 1659 | 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) 19:11:12 INFO - PROCESS | 1659 | RSS: Main: 284028928 19:11:12 INFO - PROCESS | 1659 | 19:11:15 INFO - PROCESS | 1659 | 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) 19:11:15 INFO - PROCESS | 1659 | RSS: Main: 286056448 19:11:15 INFO - PROCESS | 1659 | 19:11:19 INFO - PROCESS | 1659 | 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) 19:11:19 INFO - PROCESS | 1659 | RSS: Main: 378433536 19:11:19 INFO - PROCESS | 1659 | 19:11:21 INFO - PROCESS | 1659 | 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) 19:11:22 INFO - PROCESS | 1659 | RSS: Main: 281313280 19:11:22 INFO - PROCESS | 1659 | 19:11:24 INFO - PROCESS | 1659 | 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) 19:11:25 INFO - PROCESS | 1659 | RSS: Main: 284774400 19:11:25 INFO - PROCESS | 1659 | 19:11:27 INFO - PROCESS | 1659 | 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) 19:11:28 INFO - PROCESS | 1659 | RSS: Main: 327258112 19:11:28 INFO - PROCESS | 1659 | 19:11:31 INFO - PROCESS | 1659 | 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) 19:11:32 INFO - PROCESS | 1659 | RSS: Main: 328486912 19:11:32 INFO - PROCESS | 1659 | 19:11:34 INFO - PROCESS | 1659 | 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) 19:11:35 INFO - PROCESS | 1659 | RSS: Main: 325328896 19:11:35 INFO - PROCESS | 1659 | 19:11:37 INFO - PROCESS | 1659 | 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) 19:11:37 INFO - PROCESS | 1659 | RSS: Main: 300711936 19:11:37 INFO - PROCESS | 1659 | 19:11:39 INFO - PROCESS | 1659 | 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) 19:11:40 INFO - PROCESS | 1659 | RSS: Main: 304275456 19:11:40 INFO - PROCESS | 1659 | 19:11:42 INFO - PROCESS | 1659 | 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) 19:11:43 INFO - PROCESS | 1659 | RSS: Main: 305725440 19:11:43 INFO - PROCESS | 1659 | 19:11:46 INFO - PROCESS | 1659 | 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) 19:11:47 INFO - PROCESS | 1659 | RSS: Main: 323485696 19:11:47 INFO - PROCESS | 1659 | 19:11:50 INFO - PROCESS | 1659 | 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) 19:11:50 INFO - PROCESS | 1659 | RSS: Main: 318070784 19:11:50 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | 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) 19:11:52 INFO - PROCESS | 1659 | RSS: Main: 362508288 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | __start_tp_report 19:11:52 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 19:11:52 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 19:11:52 INFO - PROCESS | 1659 | |i|pagename|runs| 19:11:52 INFO - PROCESS | 1659 | |0;ai-astar;116;115;114;112;111;115;115;112;113;113 19:11:52 INFO - PROCESS | 1659 | |1;audio-beat-detection;143;111;110;168;142;143;114;118;157;137 19:11:52 INFO - PROCESS | 1659 | |2;audio-dft;188;184;183;183;186;181;184;183;185;184 19:11:52 INFO - PROCESS | 1659 | |3;audio-fft;80;60;60;91;66;88;64;61;77;59 19:11:52 INFO - PROCESS | 1659 | |4;audio-oscillator;91;71;87;69;70;70;86;68;68;85 19:11:52 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;86;86;86;86;86;86;86;87;86;86 19:11:52 INFO - PROCESS | 1659 | |6;imaging-darkroom;94;94;94;94;93;94;94;95;94;93 19:11:52 INFO - PROCESS | 1659 | |7;imaging-desaturate;108;141;131;85;85;86;84;85;87;107 19:11:52 INFO - PROCESS | 1659 | |8;json-parse-financial;61;58;57;56;57;59;59;59;58;57 19:11:52 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;64;71;68;73;71;68;69;70;72;71 19:11:52 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;90;89;88;88;88;89;87;89;89;88 19:11:52 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;145;146;145;142;148;132;147;139;200;152 19:11:52 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;175;171;172;175;172;173;163;160;214;225 19:11:52 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;68;68;69;67;68;70;78;82;80;82 19:11:52 INFO - PROCESS | 1659 | __end_tp_report 19:11:52 INFO - PROCESS | 1659 | __start_cc_report 19:11:52 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2232 19:11:52 INFO - PROCESS | 1659 | __end_cc_report 19:11:52 INFO - PROCESS | 1659 | __startTimestamp1487733112967__endTimestamp 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | ------- Summary: start ------- 19:11:52 INFO - PROCESS | 1659 | Number of tests: 14 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:113.60 Median:114.50 stddev:1.65 (1.4%) stddev-sans-first:1.50 19:11:52 INFO - PROCESS | 1659 | Values: 116.0 115.0 114.0 112.0 111.0 115.0 115.0 112.0 113.0 113.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:134.30 Median:142.50 stddev:20.22 (14.2%) stddev-sans-first:21.20 19:11:52 INFO - PROCESS | 1659 | Values: 143.0 111.0 110.0 168.0 142.0 143.0 114.0 118.0 157.0 137.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:184.10 Median:184.00 stddev:1.91 (1.0%) stddev-sans-first:1.41 19:11:52 INFO - PROCESS | 1659 | Values: 188.0 184.0 183.0 183.0 186.0 181.0 184.0 183.0 185.0 184.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:70.60 Median:71.50 stddev:12.31 (17.2%) stddev-sans-first:12.58 19:11:52 INFO - PROCESS | 1659 | Values: 80.0 60.0 60.0 91.0 66.0 88.0 64.0 61.0 77.0 59.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:78.00 stddev:9.42 (12.1%) stddev-sans-first:8.40 19:11:52 INFO - PROCESS | 1659 | Values: 91.0 71.0 87.0 69.0 70.0 70.0 86.0 68.0 68.0 85.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:86.10 Median:86.00 stddev:0.32 (0.4%) stddev-sans-first:0.33 19:11:52 INFO - PROCESS | 1659 | Values: 86.0 86.0 86.0 86.0 86.0 86.0 86.0 87.0 86.0 86.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 19:11:52 INFO - PROCESS | 1659 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 94.0 95.0 94.0 93.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:99.90 Median:85.00 stddev:21.22 (25.0%) stddev-sans-first:22.30 19:11:52 INFO - PROCESS | 1659 | Values: 108.0 141.0 131.0 85.0 85.0 86.0 84.0 85.0 87.0 107.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:58.50 stddev:1.45 (2.5%) stddev-sans-first:1.09 19:11:52 INFO - PROCESS | 1659 | Values: 61.0 58.0 57.0 56.0 57.0 59.0 59.0 59.0 58.0 57.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:71.00 stddev:2.58 (3.6%) stddev-sans-first:1.73 19:11:52 INFO - PROCESS | 1659 | Values: 64.0 71.0 68.0 73.0 71.0 68.0 69.0 70.0 72.0 71.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.00 stddev:0.85 (1.0%) stddev-sans-first:0.71 19:11:52 INFO - PROCESS | 1659 | Values: 90.0 89.0 88.0 88.0 88.0 89.0 87.0 89.0 89.0 88.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:146.50 stddev:18.53 (12.6%) stddev-sans-first:19.58 19:11:52 INFO - PROCESS | 1659 | Values: 145.0 146.0 145.0 142.0 148.0 132.0 147.0 139.0 200.0 152.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:174.00 stddev:21.55 (12.4%) stddev-sans-first:22.78 19:11:52 INFO - PROCESS | 1659 | Values: 175.0 171.0 172.0 175.0 172.0 173.0 163.0 160.0 214.0 225.0 19:11:52 INFO - PROCESS | 1659 | 19:11:52 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.20 Median:74.00 stddev:6.43 (8.7%) stddev-sans-first:6.53 19:11:52 INFO - PROCESS | 1659 | Values: 68.0 68.0 69.0 67.0 68.0 70.0 78.0 82.0 80.0 82.0 19:11:52 INFO - PROCESS | 1659 | -------- Summary: end -------- 19:11:52 INFO - PROCESS | 1659 | 19:11:54 INFO - TEST-INFO | 1659: exit 0 19:11:54 INFO - TEST-OK | kraken | took 60957ms 19:11:54 INFO - SUITE-END | took 1181s 19:11:54 INFO - Completed test suite (00:19:41) 19:11:54 INFO - javascript benchmark 19:11:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7104.202498539634, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3281.6226133994596, 3295.093849191472, 3314.999999999999, 3326.434506133957, 3361.5461912641786, 5462.399136095027, 5563.833085007446, 5611.018071837428, 5658.43415658434, 5714.828555143342, 5472.0, 5533.0, 5533.750981205845, 5535.944640553604, 5558.916616250759, 5041.521055499722, 5062.797488100471, 5090.567301779353, 5132.486751324856, 5143.09995750744, 5123.897522049557, 5193.948060519403, 5196.038732834438, 5209.062368773619, 5215.843524694246, 5159.974200128994, 5169.974150129263, 5171.198464238049, 5175.637705360627, 5179.8446046618665, 5159.509846564608, 5175.120229560965, 5175.301334319856, 5182.481751824825, 5185.611079169059, 4982.202847544412, 5126.359205099363, 5128.948710512885, 5130.563902068328, 5136.614753893473, 5655.321361436613, 5777.855553611152, 5786.797462088849, 5791.971040144772, 5799.826005219808, 6141.754329826802, 6172.012478003543, 6182.969085154546, 6184.474319682832, 6209.068639704081, 6074.969625151846, 6102.45895535354, 6158.860610787019, 6159.5072394208355, 6167.167432396659, 4164.250434921712, 5690.146478028288, 5712.0860662293835, 5731.742071606787, 5735.139729040636, 6109.938900611026, 6148.6925653717135, 6159.907601385983, 6162.907556386658, 6172.043333283348, 6007.219061521974, 6014.48876845473, 6024.096385542204, 6029.065494848305, 6043.0, 6048.848778780566, 6102.603330783485, 6105.163806164722, 6106.4809491192855, 6144.692765361714, 6146.262448506119, 6173.660448675366, 6178.382161783876, 6180.258368995749, 6184.103305020747, 6139.84650383744, 6163.414475624809, 6184.474319682788, 6191.9690401547705, 6195.81412557624, 4769.689970151929, 4811.975940120277, 4863.392075990501, 4873.049755297754, 4928.211486162197, 4364.8254069837485, 4426.380306757057, 4431.7340959542535, 4436.223660859337, 4438.533953934791, 5686.061799803069, 5695.658260504383, 5698.00284950132, 5702.885942281131, 5704.942950570441, 6187.3503282155625, 6220.844478888064, 6227.719752611143, 6238.968805155945, 6241.531885108635, 5521.558275338044, 5572.3870374258795, 5581.776728930798, 5609.971950140223, 5617.522510586646, 5275.841724748264, 5289.18017707256, 5295.761690723926, 5317.760700768475, 5317.973410132925, 6230.59501132434, 6231.3145553988115, 6245.219347581552, 6249.468795152463, 6255.186825712719, 6114.449440885012, 6128.961487065963, 6135.2326666699655, 6138.541671868701, 6142.7136481981925, 6206.782762603287, 6212.347703491249, 6213.130161777264, 6234.844128896814, 6244.875102498016, 6144.771045790771, 6153.600015998945, 6163.19878415803, 6168.691565421801, 6174.629522228681, 6039.335673075871, 6192.0, 6225.128482012431, 6236.126942228182, 6259.561830671809, 5811.0, 5859.2382990211, 5867.031939730067, 5941.989861723604, 6054.424829641177, 5864.179014937827, 5876.706164691663, 5877.0, 5878.0, 5883.2057672213705, 5613.214150018919, 5723.112917497794, 5732.799352022659, 5827.475527202572, 5878.382769809108, 6071.5446341523675, 6078.665673388006, 6078.848028799315, 6109.938900610937, 6112.602680825732, 5898.056310990221, 5900.527957763283, 5902.20320256777, 5904.763809447574, 5918.3489816121055], "value": 5620.3942790107485, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.0761861518735, 479.7121726963821, 492.13630079210986, 512.8256392826438, 519.5869283919284, 28154.436911261764, 28578.714212857893, 40440.0, 42569.574304257025, 42681.57318426815, 41332.760017199456, 43456.348154777625, 43559.0, 43563.128737425235, 43691.3446298305, 9482.383645063066, 9716.611335546604, 9720.805583888354, 9723.805523889518, 9727.562259698296, 7524.360429363511, 7743.961280193591, 9478.763030924247, 11473.713157171096, 11823.231489953168, 10724.981126792942, 10992.03215131914, 11697.649070527856, 11699.766004679901, 11713.1215158863, 11677.948984591385, 11737.237079589799, 11737.647870563897, 11743.11926605508, 11745.060395168366, 7527.284907933792, 7744.380449564022, 7744.922550774477, 7794.41541884361, 11529.308241505452, 32863.6713632863, 34817.6518234817, 40487.19025619471, 41529.37705934414, 42572.57427425717, 3787.5265591801026, 3792.943105853414, 3802.657760801541, 3850.557185923599, 3960.980195099035, 29859.70140298591, 29958.0, 29974.0, 31113.222169445944, 31248.906288279803, 3124.4376012317775, 3136.200268931431, 3147.5278708193723, 3150.5431712401573, 3155.984220078908, 328653.7134628647, 329646.0, 329877.3506132478, 329964.0, 333547.0, 49523.50476495189, 60593.09110363348, 60922.0, 60925.0, 60972.390276096674, 71935.6403217991, 72183.0, 73769.0, 73980.63009684917, 74983.25016749871, 11698.654654714817, 12720.173188742701, 13136.60590182296, 13429.865701342862, 13452.596422107352, 10332.431716255527, 11590.594329198437, 11735.823962640567, 11840.881591183977, 11950.88049119515, 19786.767168341925, 20284.188632454538, 20313.89843050805, 20314.59370812605, 20345.422279987182, 8071.515709057476, 8178.0, 8191.3787587972465, 8191.426600138052, 8252.298554622925, 839.8950131233596, 844.50174397106, 850.7150104714866, 861.7500924731883, 868.3357231717741, 28892.42215155685, 29358.26604334866, 29507.91962057423, 29934.0, 30796.846015769777, 1025.9743506412399, 1032.5611615063717, 1055.7782865598156, 1065.2543219746208, 1167.9474423650956, 14415.711685766226, 14581.781273280909, 15462.301932787832, 15684.624712316472, 15749.370025199092, 596345.0, 604660.0, 605371.0, 606231.0, 606855.9657201774, 58855.70572147112, 59334.40665593375, 59394.0, 59477.0, 59633.0, 1343.6237853401062, 1396.5839098359895, 1396.860313968595, 1396.9930150349182, 1401.9299035048207, 26786.062487812833, 27007.86496067507, 28564.0, 28612.713872861004, 29193.85403072971, 50198.99602008012, 50645.0, 50655.746721267635, 50763.98472030613, 50773.74613126911, 473077.0, 495995.0, 498791.0, 499379.0, 499625.5018724883, 30318.69681303247, 31845.20386990344, 40267.798661006505, 40303.59696402998, 41174.58825411707, 38050.80974595109, 44599.77700111608, 45217.54782452133, 46433.53566464292, 46485.3027204599, 33166.67881349719, 34924.65075349214, 36767.63232367642, 37763.05592360103, 38062.42906356351, 36365.63634363622, 37186.62813371832, 37618.623813761515, 37849.4322585156, 38001.0, 36203.45694814527, 36645.45031824578, 37497.87506374813, 37542.624573753914, 37668.81165594154, 29157.7084229155, 32559.18602034968, 32798.01605951825, 32827.67172328246, 33122.83438582792, 22201.888990554944, 23743.643845342678, 23752.168674097014, 24351.391215219763, 24919.626205606568], "value": 19635.84656560798, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.7906845426971, 361.37121408748783, 384.45983393332375, 394.65073410032113, 425.7679564637272, 13776.517821876236, 14381.568552943416, 17807.376741814038, 19899.204031838726, 21331.25340613079, 20537.589248215063, 20970.475738106554, 21143.894280528613, 21158.788412115875, 21343.25298614549, 5875.529957603381, 6086.087086936973, 6136.7545298188015, 6153.261608606974, 6154.230721159855, 5140.2546630738525, 5777.797777077803, 5990.640561566298, 6058.697065146747, 6060.181875446802, 6017.8194654160225, 6021.819345419644, 6026.758929642831, 6029.758809647609, 6044.818655440344, 5753.798617048405, 5946.375630558816, 6014.789482368096, 6016.75932962681, 6019.458248757589, 5150.562202212816, 5200.063988482072, 5222.97388513055, 5223.52988231061, 5227.60792940531, 25025.49949001028, 25282.620760688606, 25335.873320633462, 25619.487610247692, 25720.356991075187, 2637.7626013658864, 2662.587298968663, 2667.0931883159624, 2678.317029157572, 2700.486907487571, 9861.753456163582, 10125.443100629462, 10343.224258180666, 12341.950934170516, 14085.225312607905, 1794.97307540387, 1814.2561549764664, 1839.8620103492292, 1851.4260579220486, 1885.641728071662, 122915.0, 123617.76382236242, 128084.0, 131691.34154329263, 148250.99999999892, 10475.528601212964, 11331.886681133083, 11465.942670286762, 11590.76818463626, 11807.940960295315, 13707.246101464316, 14100.0, 14128.222947737973, 14750.852491475163, 14757.852421475862, 8083.0, 8194.672213111528, 8214.8357032859, 8223.629936652866, 8325.417220794487, 7025.367716905503, 7091.964540177266, 7802.761853830597, 7976.242256985577, 7990.520568765893, 4590.816367345269, 4636.5131661175765, 4650.837220697259, 4727.881802954954, 4800.0, 1721.9741703874452, 1974.2004488182308, 2018.3238615064117, 2023.4233243525525, 2032.156654988193, 822.1860358245294, 995.9701208963743, 1005.3264312910368, 1011.7723512209694, 1041.4584416103585, 20393.0, 20417.97910104489, 20443.79556204419, 20454.284100056426, 20472.18111275562, 946.2524605561667, 1009.8990100989843, 1015.7714514234239, 1053.510117795229, 1055.3562326980536, 9883.604655813688, 10152.796944061078, 10546.998035186645, 10585.947070264754, 10654.094401975764, 535510.0, 538706.0, 541839.0, 672846.0, 705679.0, 115400.0, 122668.0, 146166.0, 152597.71103433458, 156975.21512392364, 1008.8461135475812, 1032.4837581209395, 1066.9519871605796, 1069.9625513107003, 1071.3946620159586, 18484.353047643268, 18687.0, 18990.24039038478, 19042.0, 19427.320043798398, 46502.0, 56783.71608141933, 57718.13422798577, 58925.0, 59731.0, 84029.57985210035, 84677.0, 85679.0, 86241.0, 87497.1250287489, 7967.2431119043595, 8019.518828870287, 8083.514989100673, 8171.142030086755, 8238.176182381714, 10864.565417383215, 12145.0, 12291.877081229073, 12518.248905065726, 12525.248485090924, 10305.072543471124, 10524.00021997909, 10568.365898046142, 10834.945825270823, 10896.0, 10370.066693997576, 10448.477576121011, 10630.202734794766, 10842.728931776768, 10902.509387077442, 10727.946360268148, 10796.244262901522, 11063.50214240345, 11080.944595276973, 11181.32912025281, 6646.0, 8073.609084184774, 8204.138565450541, 8440.366972476966, 8448.493090414595, 10501.684949451528, 10538.525766340686, 10784.89215107839, 10803.945980270048, 10838.0], "value": 9645.309495160858, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1419.7302512522622, 1446.6238777917745, 1465.2161093814798, 1466.9339879705406, 1488.1591900576177, 8009.759707208786, 8462.280706139978, 8462.449940753846, 8467.195616416446, 8468.280196183325, 8097.959510202455, 8372.413931024816, 8382.748517544469, 8473.237408633222, 8486.575671216446, 2012.0040579912963, 2118.8304935605115, 2148.892555372233, 2238.664200369941, 2316.0, 2297.632378819389, 2319.3042087373806, 2331.3006098170567, 2332.9236979088623, 2336.100601268515, 2268.4895898422888, 2287.313805858244, 2306.3888069661552, 2307.4231442139467, 2308.076769292288, 2277.567262220181, 2287.759785222561, 2296.3570200343847, 2301.838871279011, 2304.2626359564947, 2269.6708977198377, 2292.289390289016, 2317.8261630377788, 2323.8373313868037, 2325.453518423169, 8420.28427583656, 8486.74539763808, 8496.915030849674, 8497.362697797627, 8513.787155321104, 5030.849074527733, 5184.922226166611, 5197.7920883164625, 5206.323177986837, 5209.817656382009, 3272.378248132847, 3323.667633236681, 3487.546618939547, 3555.7866528008144, 3573.3210689968823, 1167.5913430299413, 1215.3376409856648, 1223.5044806853239, 1239.9752004959942, 1253.5988483685223, 9993.300468967103, 10263.178945684327, 10298.999999999925, 10701.304415212986, 10754.623588174376, 4081.836726530965, 4185.811638476276, 4186.916261674811, 4188.643965262926, 4199.181159673895, 8621.31029517637, 8742.994555626057, 8756.430831996027, 8831.823363532694, 8847.46915185091, 4961.933184365379, 5038.042771873333, 5040.521150490697, 5043.5460808527405, 5051.898962020739, 4582.495925448198, 4700.741459219707, 4736.573708366263, 4786.2581299898575, 4823.710577365369, 3055.220918665726, 3493.8951831445097, 3623.7463377563845, 3664.3953747631344, 3666.505021822073, 894.9955250223837, 1018.5009345420839, 1019.6635110413546, 1022.1532635043709, 1033.6898930320874, 691.695653912277, 755.7354925775934, 760.7755712064954, 788.4402074527035, 824.2787560884226, 5292.444293349143, 5340.465953404629, 5422.783088676409, 5537.667739935617, 5624.803131890364, 545.4490964126181, 546.5572885962383, 578.9768409263582, 586.3637952821236, 592.3957563285425, 2976.538636511344, 3605.20685449206, 3644.3053979899473, 3710.350688629479, 3755.117547376364, 8618.482891026559, 8889.111088891188, 8999.415038022507, 9799.608015679292, 9913.55389007482, 9700.757481062888, 9840.966698496697, 9856.845809341085, 9857.35927164732, 9857.753556161153, 7625.6568454419685, 7735.806604834924, 7751.108622508484, 7757.418193635387, 7780.14418413974, 5180.870478238075, 5428.158635411518, 5485.725713714219, 5493.450654934474, 5495.505404513613, 8892.199702026848, 8935.553222338727, 9039.276857851488, 9107.954460227656, 9183.403078799856, 7021.648917554204, 9228.584713687766, 9286.34995550305, 9325.347225694137, 9334.113259240361, 6130.47890929276, 6674.532782705358, 6749.392554670103, 6765.154355705537, 6775.695093720893, 7162.534435261691, 7241.746538871114, 7917.327027202752, 7982.6008699565955, 8059.5164290142775, 7022.754203602849, 7091.184513780981, 7100.964495177491, 7197.928020719935, 7268.127824661075, 6950.131233595801, 6965.199002114619, 6969.4424446045205, 7036.0, 7053.294670532906, 5968.701564921824, 6167.660778657217, 6228.688565571794, 6261.342559031418, 6306.369363063657, 4839.951600484091, 4863.440704319049, 4868.537488938545, 4899.280899100891, 5043.798248070036, 4295.72077814941, 4358.716683415568, 4995.675281106716, 5005.724685142207, 5057.620678449058], "value": 4224.5196153880615, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.5665374935081, 356.2198784661591, 364.5315769236532, 367.5662717992771, 371.72863809419124, 4601.0, 5097.59219262459, 5107.131787596109, 5109.105906466363, 5147.562457191134, 4370.431843860301, 4745.240761478164, 4809.687370320927, 4876.756162191894, 5031.660277970743, 3416.829158542075, 3809.1810260793923, 3887.669548088402, 3912.804359782021, 3927.70542209334, 3325.9501107483406, 3668.578113516953, 3774.830132644038, 3823.847046118152, 3933.9213215735667, 3729.533808273966, 3818.503594532721, 3904.882853514385, 3910.198409326081, 3919.98040009801, 3336.7664263501565, 3844.596317386676, 3867.5165604299464, 3909.4135879618, 3912.510936132969, 3349.5478110455265, 3354.194993201638, 3354.3794398036443, 3358.177246574605, 3372.392969265531, 4703.858884233478, 4754.904901901942, 4963.726995015273, 4977.651564390494, 4985.401751789772, 3871.4967054283043, 3984.8282685935947, 4245.8513952011845, 4432.874823249601, 4462.594282800907, 5372.865678358073, 5389.703566303851, 5390.00284947286, 5392.676439413648, 5404.270423492818, 3693.9287606594057, 3703.3889408247605, 3735.6077611850906, 3741.7754934704003, 3741.9625803741887, 4723.625240093929, 5248.501392367719, 5350.34139416782, 5574.470425309589, 5651.350094739117, 3188.744900408008, 3432.7597068204986, 3463.9826800865835, 3602.5857026442295, 3735.43968404736, 3675.8162091895297, 3776.999095239764, 3780.697544196458, 3783.770274660746, 3819.923601527954, 4388.012697143181, 4388.451443569554, 4390.487609912057, 4399.21831658179, 4414.911701765946, 4644.767761611906, 4800.783964721596, 4969.676970996874, 5232.0, 5428.9185662215095, 1129.4014172488594, 1168.0772189969998, 1217.3608855351013, 1247.6880779805049, 1248.7003119251315, 723.9384652304508, 831.193742070191, 843.9071702112763, 848.1857416879865, 850.3036442297656, 4679.43239014927, 4832.487106704494, 4853.611711063107, 4853.975730121327, 4855.295982082649, 4151.481064866892, 4261.552536983634, 4980.352554167935, 5149.031184906583, 5287.550558202519, 4282.828686852553, 4581.9690569622235, 4841.975790121027, 4863.683860549124, 4884.898089712987, 2487.743689436859, 2760.5997130415976, 2775.680796708364, 2787.567926971323, 2788.024191532947, 5117.136561895745, 5207.791688332424, 5446.618736688473, 5454.318210223722, 5531.474509921551, 4885.242787367893, 4943.555080042814, 5196.844094677166, 5281.524662780368, 5403.702796346239, 5259.342582177228, 5629.746661400165, 5670.801521946877, 5671.461211184931, 5698.230738850285, 4399.560043995575, 5325.434920508156, 5492.835214943558, 5525.972370138124, 5599.636023658449, 4913.901721965469, 5115.641905066758, 5413.918791218213, 5473.713677285755, 5484.725763711878, 4967.031428871335, 5328.440513746156, 5675.772969081356, 5681.403452637579, 5690.544756419394, 3251.9837400812844, 3497.772644778183, 3557.5019497269886, 3717.386631205821, 3729.664330210294, 4969.801207951786, 5110.872228194325, 5240.397354304304, 5266.786570743467, 5541.362743284574, 4933.383327084114, 4961.404631444249, 5358.169483730028, 5383.946160538501, 5386.8383948481605, 4786.7845946931775, 5135.306733591066, 5194.922076168936, 5367.570594352364, 5383.461653834585, 4894.608431325414, 4953.356063711839, 4986.526280003394, 5259.4477579853565, 5262.526372626482, 4723.811047558059, 5080.339555857715, 5355.3305836770405, 5358.767483478744, 5380.43505431924, 4162.917641413315, 4976.0, 5139.434662187082, 5225.399079105951, 5278.36659600835], "value": 3884.9066934337, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.1986055756994, 716.5306724095716, 754.5005512897213, 757.9048275242276, 816.1919699497497, 14548.56354309371, 14563.27183640819, 14967.625809354786, 15070.0, 15215.315310811013, 10817.729556761085, 12494.687632809184, 12516.624501264954, 12613.810792838092, 12636.0, 878.9560521973908, 915.3226612306895, 921.6543796076471, 926.9443833369986, 932.0632764072099, 904.7602385367883, 926.1942110363992, 928.3501548915752, 930.6137952749601, 936.1574582875432, 817.6606708216113, 965.7971825916566, 968.7868668892833, 969.6945462179426, 971.4171497101753, 967.5984466446416, 967.709687093869, 967.8741763570725, 968.4963818814177, 968.840141376672, 727.3126895084148, 728.1226122522348, 728.4209053802186, 728.5118970289918, 729.1104852080454, 15022.94839361245, 15196.0, 15362.692746145127, 15618.984765990173, 15681.294341754648, 13460.932695336558, 13750.65623359414, 13955.79066314006, 14258.64353391163, 14384.424623015067, 10762.139028877671, 11099.55601775928, 11179.60871369498, 11587.188896777228, 12126.454309556002, 4020.3768415895584, 4398.53415479245, 4413.6910416270875, 4476.709013914117, 4607.17070927233, 90210.0, 103023.0, 104192.39519012009, 106470.0, 108165.31602917533, 9183.816323673624, 10558.788824223473, 10633.096186824207, 10790.0, 10955.233133680566, 19556.21775128979, 20435.284765033153, 21023.78976210249, 21450.57098858014, 21481.140754369964, 7238.167610724834, 7338.559686418832, 7358.043454351007, 7385.8153546161775, 7528.887066694004, 4000.2599519089063, 4082.101937573729, 4085.264652362603, 4089.1821635672986, 4089.5297040840087, 3483.5819701635965, 3575.6245594212232, 3611.9277614447565, 3615.222727113683, 3624.9637503624626, 656.7569999100364, 662.9502787290972, 664.4485077385758, 679.6941376380648, 686.4439803758971, 511.3148381169251, 512.6206607110711, 515.7704821354462, 529.875479262373, 557.0140850694329, 8477.27943124829, 8879.733607991771, 8894.73315800527, 9431.76420589477, 9579.13787759091, 641.2241188162376, 648.4552975500602, 659.8053574195528, 665.3679004945321, 669.3540733192492, 4261.01837843198, 4351.97824010878, 4547.431571053618, 4551.977240113844, 4565.429321334833, 89050.0, 89756.5512172435, 90066.54966725255, 90778.54610726904, 91950.0, 78593.0, 80114.5994270025, 81619.5919020401, 91411.54294228487, 94338.0, 69297.30702692909, 69947.65026174938, 70995.64502177559, 75095.0, 75356.0, 10527.0, 10531.420771857314, 10560.947195263974, 10737.838932416176, 10807.729806754895, 39937.600623993385, 42569.0, 47359.76320118377, 48662.5133748658, 50795.74602126966, 63756.68121659362, 64067.35932640614, 65484.017739734896, 65679.34320656733, 66094.33905660882, 12955.481780728665, 13009.154404963647, 13116.803247951479, 13295.335233238493, 13414.932925335701, 14281.071730337495, 14339.426422942965, 14485.51001853154, 14501.347439365465, 14512.927435362755, 13204.80192797128, 13518.25649589282, 13562.525311614441, 13723.725525489634, 13778.448862045407, 13276.336183190995, 13360.86639133635, 13379.0, 13425.462981480632, 13705.177689338672, 13374.531891383755, 13424.127431716906, 13428.0, 13659.795103073264, 13808.516701915385, 9212.263018958602, 10394.740131496774, 10741.140708743438, 10834.065230659315, 11114.777704446027, 9210.585523651585, 9415.340926135104, 10630.574777008833, 10636.0, 10650.0], "value": 7357.838685163591, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1478.1000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 112.0, 111.0, 115.0, 115.0, 112.0, 113.0, 113.0], "value": 113.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 110.0, 168.0, 142.0, 143.0, 114.0, 118.0, 157.0, 137.0], "value": 134.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 184.0, 183.0, 183.0, 186.0, 181.0, 184.0, 183.0, 185.0, 184.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 91.0, 66.0, 88.0, 64.0, 61.0, 77.0, 59.0], "value": 70.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 87.0, 69.0, 70.0, 70.0, 86.0, 68.0, 68.0, 85.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 86.0, 87.0, 86.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 95.0, 94.0, 93.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 141.0, 131.0, 85.0, 85.0, 86.0, 84.0, 85.0, 87.0, 107.0], "value": 99.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 57.0, 56.0, 57.0, 59.0, 59.0, 59.0, 58.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 68.0, 73.0, 71.0, 68.0, 69.0, 70.0, 72.0, 71.0], "value": 69.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 88.0, 88.0, 88.0, 89.0, 87.0, 89.0, 89.0, 88.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 142.0, 148.0, 132.0, 147.0, 139.0, 200.0, 152.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 171.0, 172.0, 175.0, 172.0, 173.0, 163.0, 160.0, 214.0, 225.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 67.0, 68.0, 70.0, 78.0, 82.0, 80.0, 82.0], "value": 73.2, "unit": "score"}]}]} 19:11:54 INFO - Return code: 0 19:11:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:11:54 ERROR - # TBPL SUCCESS # 19:11:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:11:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:11:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:11:54 INFO - 2017-02-21 19:11:54.284 screenresolution[1663:10102] starting screenresolution argv=screenresolution get 19:11:54 INFO - 2017-02-21 19:11:54.287 screenresolution[1663:10102] Display 0: 1600x1200x32@60 19:11:54 INFO - 2017-02-21 19:11:54.293 screenresolution[1664:10105] starting screenresolution argv=screenresolution list 19:11:54 INFO - Available Modes on Display 0 19:11:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:11:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:11:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:11:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:11:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:11:54 INFO - Intel Iris: 19:11:54 INFO - Chipset Model: Intel Iris 19:11:54 INFO - Type: GPU 19:11:54 INFO - Bus: Built-In 19:11:54 INFO - VRAM (Dynamic, Max): 1536 MB 19:11:54 INFO - Vendor: Intel (0x8086) 19:11:54 INFO - Device ID: 0x0a2e 19:11:54 INFO - Revision ID: 0x0009 19:11:54 INFO - Displays: 19:11:54 INFO - Display: 19:11:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:11:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:11:54 INFO - Display Serial Number: 1600x1200 60 19:11:54 INFO - Main Display: Yes 19:11:54 INFO - Mirror: Off 19:11:54 INFO - Online: Yes 19:11:54 INFO - Rotation: Supported 19:11:54 INFO - Return code: 0 19:11:54 INFO - Running post-action listener: _resource_record_post_action 19:11:54 INFO - [mozharness: 2017-02-22 03:11:54.540549Z] Finished run-tests step (success) 19:11:54 INFO - Running post-run listener: _resource_record_post_run 19:11:54 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 44398080; Write bytes: 512022528; Read time: 271; Write time: 1606 19:11:54 INFO - TinderboxPrint: CPU usage
54.0% 19:11:54 INFO - TinderboxPrint: I/O read bytes / time
44,398,080 / 271 19:11:54 INFO - TinderboxPrint: I/O write bytes / time
512,022,528 / 1,606 19:11:54 INFO - TinderboxPrint: CPU idle
2,211.5 (46.0%) 19:11:54 INFO - TinderboxPrint: CPU system
964.5 (20.1%) 19:11:54 INFO - TinderboxPrint: CPU user
1,633.7 (34.0%) 19:11:54 INFO - TinderboxPrint: Swap in / out
261,828,608 / 0 19:11:54 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 211507712; Write bytes: 205584384; Read time: 15968; Write time: 458 19:11:54 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 40740352; Write bytes: 296435712; Read time: 246; Write time: 1113 19:11:55 INFO - Running post-run listener: _upload_blobber_files 19:11:55 INFO - Blob upload gear active. 19:11:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:11:55 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 19:11:55 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:11:55 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:11:55 INFO - (blobuploader) - INFO - Open directory for files ... 19:11:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 19:11:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:11:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 19:11:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:11:56 INFO - (blobuploader) - INFO - Done attempting. 19:11:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 19:11:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:11:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 19:11:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:11:57 INFO - (blobuploader) - INFO - Done attempting. 19:11:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:11:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:11:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:11:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:11:58 INFO - (blobuploader) - INFO - Done attempting. 19:11:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:11:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:11:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:12:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:12:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:12:01 INFO - (blobuploader) - INFO - Done attempting. 19:12:01 INFO - (blobuploader) - INFO - Iteration through files over. 19:12:01 INFO - Return code: 0 19:12:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:12:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:12:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89c7cbddbb86bc36beb622df40b5620831a33dfc6d4c386bedad3fa67f4c20de770f88bd23b4ebc4a842d378d53d02216fe048d228d68796b9bf060466450836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f3a2c1266b383146948c3584f81de98d6b25536cf8e2b15dfa0061f6efacabf329f1fe2bf0c91d1896c519f5acfc21e4848b3ed211850e307f716aa2227a15c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e84783adbbe7b08d971e18c3c1bd5d7caf727a334c92c30263d877cd62d6e1ae904dd3f1a9efe1746320daba9b380b7732e0c2f308bb9179374bea4ea861144", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d17d6d0ae5c9919ceb905d2c94edf805b9cc49fd4e8d4287b974370ab237a527bc0238a9739c5d80ddf7d1a93b668b22f90fceb70b7fa316f5aa7f726587b660"} 19:12:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:12:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:12:01 INFO - Contents: 19:12:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89c7cbddbb86bc36beb622df40b5620831a33dfc6d4c386bedad3fa67f4c20de770f88bd23b4ebc4a842d378d53d02216fe048d228d68796b9bf060466450836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f3a2c1266b383146948c3584f81de98d6b25536cf8e2b15dfa0061f6efacabf329f1fe2bf0c91d1896c519f5acfc21e4848b3ed211850e307f716aa2227a15c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e84783adbbe7b08d971e18c3c1bd5d7caf727a334c92c30263d877cd62d6e1ae904dd3f1a9efe1746320daba9b380b7732e0c2f308bb9179374bea4ea861144", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d17d6d0ae5c9919ceb905d2c94edf805b9cc49fd4e8d4287b974370ab237a527bc0238a9739c5d80ddf7d1a93b668b22f90fceb70b7fa316f5aa7f726587b660"} 19:12:01 INFO - Running post-run listener: copy_logs_to_upload_dir 19:12:01 INFO - Copying logs to upload dir... 19:12:01 INFO - mkdir: /builds/slave/test/build/upload/logs 19:12:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.476223 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-02-21 19:12:01.405522) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 19:12:01.414699) ========= 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.DMVyblYW6g/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.nVqgUMz221/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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/Firefox/sha512/89c7cbddbb86bc36beb622df40b5620831a33dfc6d4c386bedad3fa67f4c20de770f88bd23b4ebc4a842d378d53d02216fe048d228d68796b9bf060466450836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f3a2c1266b383146948c3584f81de98d6b25536cf8e2b15dfa0061f6efacabf329f1fe2bf0c91d1896c519f5acfc21e4848b3ed211850e307f716aa2227a15c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e84783adbbe7b08d971e18c3c1bd5d7caf727a334c92c30263d877cd62d6e1ae904dd3f1a9efe1746320daba9b380b7732e0c2f308bb9179374bea4ea861144", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d17d6d0ae5c9919ceb905d2c94edf805b9cc49fd4e8d4287b974370ab237a527bc0238a9739c5d80ddf7d1a93b668b22f90fceb70b7fa316f5aa7f726587b660"} build_url:https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011002 build_url: 'https://queue.taskcluster.net/v1/task/E405ph3aT6SulwhKWkkdyw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/89c7cbddbb86bc36beb622df40b5620831a33dfc6d4c386bedad3fa67f4c20de770f88bd23b4ebc4a842d378d53d02216fe048d228d68796b9bf060466450836", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9f3a2c1266b383146948c3584f81de98d6b25536cf8e2b15dfa0061f6efacabf329f1fe2bf0c91d1896c519f5acfc21e4848b3ed211850e307f716aa2227a15c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5e84783adbbe7b08d971e18c3c1bd5d7caf727a334c92c30263d877cd62d6e1ae904dd3f1a9efe1746320daba9b380b7732e0c2f308bb9179374bea4ea861144", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d17d6d0ae5c9919ceb905d2c94edf805b9cc49fd4e8d4287b974370ab237a527bc0238a9739c5d80ddf7d1a93b668b22f90fceb70b7fa316f5aa7f726587b660"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-21 19:12:01.450141) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 19:12:01.450471) ========= 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.DMVyblYW6g/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.nVqgUMz221/Listeners TMPDIR=/var/folders/97/rkh_tff557l6vj3yx2fd921000000w/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.005166 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-21 19:12:01.499123) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 19:12:01.499492) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-21 19:12:01.499905) ========= ========= Total master_lag: 0.19 =========