builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0299 starttime: 1487776979.46 results: success (0) buildid: 20170222053126 builduid: 0a557c3d85ea4c18888dcdf171278609 revision: 8a6084bc234ceb6036af6c660c5162cde5eaf047 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 07:22:59.455384) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-22 07:22:59.455838) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 07:22:59.456136) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-22 07:22:59.480795) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 07:22:59.481068) ========= 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.nSfO2OFeSX/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.utpNaEZBVq/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-22 07:22:59-- 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% 153M=0s 2017-02-22 07:22:59 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.148506 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 07:22:59.656238) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 07:22:59.656950) ========= 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.nSfO2OFeSX/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.utpNaEZBVq/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.020264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 07:22:59.706157) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 07:22:59.706484) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8a6084bc234ceb6036af6c660c5162cde5eaf047 --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 8a6084bc234ceb6036af6c660c5162cde5eaf047 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.nSfO2OFeSX/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.utpNaEZBVq/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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-22 07:22:59,805 truncating revision to first 12 chars 2017-02-22 07:22:59,805 Setting DEBUG logging. 2017-02-22 07:22:59,805 attempt 1/10 2017-02-22 07:22:59,805 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8a6084bc234c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-22 07:23:01,113 unpacking tar archive at: mozilla-central-8a6084bc234c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.559357 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-22 07:23:01.289219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 07:23:01.289547) ========= script_repo_revision: 8a6084bc234ceb6036af6c660c5162cde5eaf047 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-22 07:23:01.289922) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 07:23:01.290176) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-22 07:23:01.310234) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-02-22 07:23:01.310608) ========= /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.nSfO2OFeSX/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.utpNaEZBVq/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:23:01 INFO - MultiFileLogger online at 20170222 07:23:01 in /builds/slave/test 07:23:01 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 07:23:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:23:01 INFO - {'append_to_log': False, 07:23:01 INFO - 'base_work_dir': '/builds/slave/test', 07:23:01 INFO - 'blob_upload_branch': 'Firefox', 07:23:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:23:01 INFO - 'branch': 'Firefox', 07:23:01 INFO - 'buildbot_json_path': 'buildprops.json', 07:23:01 INFO - 'config_files': ('talos/mac_config.py',), 07:23:01 INFO - 'default_actions': ('clobber', 07:23:01 INFO - 'read-buildbot-config', 07:23:01 INFO - 'download-and-extract', 07:23:01 INFO - 'populate-webroot', 07:23:01 INFO - 'create-virtualenv', 07:23:01 INFO - 'install', 07:23:01 INFO - 'run-tests'), 07:23:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:23:01 INFO - 'download_minidump_stackwalk': True, 07:23:01 INFO - 'download_symbols': 'ondemand', 07:23:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:23:01 INFO - 'tooltool.py': '/tools/tooltool.py', 07:23:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:23:01 INFO - '/tools/misc-python/virtualenv.py')}, 07:23:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:23:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:23:01 INFO - 'gecko_profile': False, 07:23:01 INFO - 'gecko_profile_interval': 0, 07:23:01 INFO - 'installer_path': 'installer.exe', 07:23:01 INFO - 'log_level': 'info', 07:23:01 INFO - 'log_name': 'talos', 07:23:01 INFO - 'log_to_console': True, 07:23:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:23:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:23:01 INFO - 'opt_config_files': (), 07:23:01 INFO - 'pip_index': False, 07:23:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:23:01 INFO - 'cmd': ('bash', 07:23:01 INFO - '-c', 07:23:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:23:01 INFO - 'enabled': True, 07:23:01 INFO - 'halt_on_failure': False, 07:23:01 INFO - 'name': 'check_screen_resolution'},), 07:23:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:23:01 INFO - 'cmd': ('bash', 07:23:01 INFO - '-c', 07:23:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:23:01 INFO - 'enabled': True, 07:23:01 INFO - 'halt_on_failure': False, 07:23:01 INFO - 'name': 'check_screen_resolution'},), 07:23:01 INFO - 'run_cmd_checks_enabled': True, 07:23:01 INFO - 'suite': 'dromaeojs', 07:23:01 INFO - 'system_bits': '32', 07:23:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:23:01 INFO - 'title': 't-yosemite-r7-0299', 07:23:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:23:01 INFO - 'use_talos_json': True, 07:23:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:23:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:23:01 INFO - 'work_dir': 'build'} 07:23:01 INFO - [mozharness: 2017-02-22 15:23:01.528714Z] Running clobber step. 07:23:01 INFO - Running pre-action listener: _resource_record_pre_action 07:23:01 INFO - Running main action method: clobber 07:23:01 INFO - rmtree: /builds/slave/test/build 07:23:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:23:01 INFO - Running post-action listener: _resource_record_post_action 07:23:01 INFO - [mozharness: 2017-02-22 15:23:01.686650Z] Finished clobber step (success) 07:23:01 INFO - [mozharness: 2017-02-22 15:23:01.686809Z] Running read-buildbot-config step. 07:23:01 INFO - Running pre-action listener: _resource_record_pre_action 07:23:01 INFO - Running main action method: read_buildbot_config 07:23:01 INFO - Using buildbot properties: 07:23:01 INFO - { 07:23:01 INFO - "project": "", 07:23:01 INFO - "product": "firefox", 07:23:01 INFO - "script_repo_revision": "production", 07:23:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:23:01 INFO - "repository": "", 07:23:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:23:01 INFO - "buildid": "20170222053126", 07:23:01 INFO - "pgo_build": "False", 07:23:01 INFO - "basedir": "/builds/slave/test", 07:23:01 INFO - "buildnumber": 2, 07:23:01 INFO - "slavename": "t-yosemite-r7-0299", 07:23:01 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:23:01 INFO - "platform": "yosemite_r7", 07:23:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:23:01 INFO - "branch": "mozilla-central", 07:23:01 INFO - "repo_path": "mozilla-central", 07:23:01 INFO - "revision": "8a6084bc234ceb6036af6c660c5162cde5eaf047", 07:23:01 INFO - "stage_platform": "macosx64", 07:23:01 INFO - "builduid": "0a557c3d85ea4c18888dcdf171278609", 07:23:01 INFO - "slavebuilddir": "test" 07:23:01 INFO - } 07:23:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 07:23:01 INFO - Running post-action listener: _resource_record_post_action 07:23:01 INFO - [mozharness: 2017-02-22 15:23:01.690219Z] Finished read-buildbot-config step (success) 07:23:01 INFO - [mozharness: 2017-02-22 15:23:01.690341Z] Running download-and-extract step. 07:23:01 INFO - Running pre-action listener: _resource_record_pre_action 07:23:01 INFO - Running main action method: download_and_extract 07:23:01 INFO - mkdir: /builds/slave/test/build/tests 07:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:01 INFO - trying https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 07:23:01 INFO - Downloading https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/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 07:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/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 07:23:03 INFO - Downloaded 1199 bytes. 07:23:03 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 07:23:03 INFO - Using the following test package requirements: 07:23:03 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:23:03 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:23:03 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 07:23:03 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:23:03 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 07:23:03 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:23:03 INFO - u'jsshell-mac.zip'], 07:23:03 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:23:03 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 07:23:03 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 07:23:03 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:23:03 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 07:23:03 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:23:03 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 07:23:03 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:23:03 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 07:23:03 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 07:23:03 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 07:23:03 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:23:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:23:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:23:03 INFO - Fetch https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:23:04 INFO - Expected file size: 51465214 07:23:04 INFO - Obtained file size: 51465214 07:23:20 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 07:23:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 07:23:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:23:20 INFO - Fetch https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 07:23:22 INFO - Expected file size: 51465214 07:23:22 INFO - Obtained file size: 51465214 07:23:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 07:23:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:23:37 INFO - Fetch https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 07:23:40 INFO - Expected file size: 14404319 07:23:40 INFO - Obtained file size: 14404319 07:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:40 INFO - trying https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:23:40 INFO - Downloading https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 07:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/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 07:23:42 INFO - Downloaded 74808432 bytes. 07:23:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:23:42 INFO - mkdir: /builds/slave/test/properties 07:23:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:23:42 INFO - Writing to file /builds/slave/test/properties/build_url 07:23:42 INFO - Contents: 07:23:42 INFO - build_url:https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 07:23:43 INFO - Running post-action listener: _resource_record_post_action 07:23:43 INFO - Running post-action listener: set_extra_try_arguments 07:23:43 INFO - [mozharness: 2017-02-22 15:23:43.342905Z] Finished download-and-extract step (success) 07:23:43 INFO - [mozharness: 2017-02-22 15:23:43.343031Z] Running populate-webroot step. 07:23:43 INFO - Running pre-action listener: _resource_record_pre_action 07:23:43 INFO - Running main action method: populate_webroot 07:23:43 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:23:43 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:23:43 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:23:43 INFO - '--tppagecycles', 07:23:43 INFO - '7'], 07:23:43 INFO - 'tests': ['tsvgm']}}, 07:23:43 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:23:43 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:23:43 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:23:43 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:23:43 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:23:43 INFO - 'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:43 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:23:43 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:23:43 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:23:43 INFO - 'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['damp', 'tps']}, 07:23:43 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:23:43 INFO - 'tests': ['damp', 'tps']}, 07:23:43 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['dromaeo_dom']}, 07:23:43 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:23:43 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['basic_compositor_video']}, 07:23:43 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:23:43 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['a11yr', 07:23:43 INFO - 'ts_paint', 07:23:43 INFO - 'tpaint', 07:23:43 INFO - 'sessionrestore', 07:23:43 INFO - 'sessionrestore_no_auto_restore', 07:23:43 INFO - 'tabpaint']}, 07:23:43 INFO - 'other-e10s': {'tests': ['a11yr', 07:23:43 INFO - 'ts_paint', 07:23:43 INFO - 'tpaint', 07:23:43 INFO - 'sessionrestore', 07:23:43 INFO - 'sessionrestore_no_auto_restore', 07:23:43 INFO - 'tabpaint']}, 07:23:43 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:23:43 INFO - 'ts_paint', 07:23:43 INFO - 'tpaint', 07:23:43 INFO - 'sessionrestore', 07:23:43 INFO - 'sessionrestore_no_auto_restore', 07:23:43 INFO - 'tabpaint']}, 07:23:43 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:23:43 INFO - 'ts_paint', 07:23:43 INFO - 'tpaint', 07:23:43 INFO - 'sessionrestore', 07:23:43 INFO - 'sessionrestore_no_auto_restore', 07:23:43 INFO - 'tabpaint']}, 07:23:43 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['a11yr', 07:23:43 INFO - 'ts_paint', 07:23:43 INFO - 'tpaint', 07:23:43 INFO - 'sessionrestore', 07:23:43 INFO - 'sessionrestore_no_auto_restore', 07:23:43 INFO - 'tabpaint']}, 07:23:43 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['a11yr', 07:23:43 INFO - 'ts_paint', 07:23:43 INFO - 'tpaint', 07:23:43 INFO - 'sessionrestore', 07:23:43 INFO - 'sessionrestore_no_auto_restore', 07:23:43 INFO - 'tabpaint']}, 07:23:43 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['tsvgx', 07:23:43 INFO - 'tsvgr_opacity', 07:23:43 INFO - 'tart', 07:23:43 INFO - 'tscrollx', 07:23:43 INFO - 'cart', 07:23:43 INFO - 'tsvg_static']}, 07:23:43 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:23:43 INFO - 'tsvgr_opacity', 07:23:43 INFO - 'tart', 07:23:43 INFO - 'tscrollx', 07:23:43 INFO - 'cart', 07:23:43 INFO - 'tsvg_static']}, 07:23:43 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:23:43 INFO - 'talos_options': ['--disable-e10s'], 07:23:43 INFO - 'tests': ['tp5o']}, 07:23:43 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:23:43 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:23:43 INFO - 'talos_options': ['--disable-e10s', 07:23:43 INFO - '--xperf_path', 07:23:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:43 INFO - 'tests': ['tp5n']}, 07:23:43 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:23:43 INFO - 'talos_options': ['--xperf_path', 07:23:43 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:23:43 INFO - 'tests': ['tp5n']}}, 07:23:43 INFO - 'talos.zip': {'path': '', 07:23:43 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:23:43 INFO - Running post-action listener: _resource_record_post_action 07:23:43 INFO - [mozharness: 2017-02-22 15:23:43.362304Z] Finished populate-webroot step (success) 07:23:43 INFO - [mozharness: 2017-02-22 15:23:43.362436Z] Running create-virtualenv step. 07:23:43 INFO - Running pre-action listener: _resource_record_pre_action 07:23:43 INFO - Running main action method: create_virtualenv 07:23:43 INFO - Creating virtualenv /builds/slave/test/build/venv 07:23:43 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:23:43 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:23:43 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:23:43 INFO - Using real prefix '/tools/python27' 07:23:43 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:23:44 INFO - Installing distribute.............................................................................................................................................................................................done. 07:23:47 INFO - Installing pip.................done. 07:23:47 INFO - Return code: 0 07:23:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:23:47 INFO - Reading from file tmpfile_stdout 07:23:47 INFO - Output received: 07:23:47 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:23:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:47 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:47 INFO - 'HOME': '/Users/cltbld', 07:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:47 INFO - 'LOGNAME': 'cltbld', 07:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:47 INFO - 'MOZ_NO_REMOTE': '1', 07:23:47 INFO - 'NO_EM_RESTART': '1', 07:23:47 INFO - 'PAGER': '/bin/cat', 07:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:47 INFO - 'PWD': '/builds/slave/test', 07:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:47 INFO - 'SHELL': '/bin/bash', 07:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:23:47 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:47 INFO - 'USER': 'cltbld', 07:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:47 INFO - 'XPC_FLAGS': '0x0', 07:23:47 INFO - 'XPC_SERVICE_NAME': '0', 07:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:47 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:23:47 INFO - Cleaning up... 07:23:47 INFO - Return code: 0 07:23:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:47 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:23:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:23:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:23:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:23:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:47 INFO - 'HOME': '/Users/cltbld', 07:23:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:47 INFO - 'LOGNAME': 'cltbld', 07:23:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:47 INFO - 'MOZ_NO_REMOTE': '1', 07:23:47 INFO - 'NO_EM_RESTART': '1', 07:23:47 INFO - 'PAGER': '/bin/cat', 07:23:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:47 INFO - 'PWD': '/builds/slave/test', 07:23:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:47 INFO - 'SHELL': '/bin/bash', 07:23:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:23:47 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:23:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:47 INFO - 'USER': 'cltbld', 07:23:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:47 INFO - 'XPC_FLAGS': '0x0', 07:23:47 INFO - 'XPC_SERVICE_NAME': '0', 07:23:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:47 INFO - Downloading/unpacking psutil>=3.1.1 07:23: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 07:23: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 07:23: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 07:23: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 07:23: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 07:23: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 07:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:23:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:51 INFO - Installing collected packages: psutil 07:23:51 INFO - Running setup.py install for psutil 07:23:51 INFO - building 'psutil._psutil_osx' extension 07:23:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:23:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:23:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:23:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:23:51 INFO - building 'psutil._psutil_posix' extension 07:23:51 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:23:51 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:23:51 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:23:51 INFO - ^ 07:23:51 INFO - 1 warning generated. 07:23:51 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:23:52 INFO - Successfully installed psutil 07:23:52 INFO - Cleaning up... 07:23:52 INFO - Return code: 0 07:23:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:53 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:23:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:23:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:53 INFO - 'HOME': '/Users/cltbld', 07:23:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:53 INFO - 'LOGNAME': 'cltbld', 07:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:53 INFO - 'MOZ_NO_REMOTE': '1', 07:23:53 INFO - 'NO_EM_RESTART': '1', 07:23:53 INFO - 'PAGER': '/bin/cat', 07:23:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:53 INFO - 'PWD': '/builds/slave/test', 07:23:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:53 INFO - 'SHELL': '/bin/bash', 07:23:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:23:53 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:23:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:53 INFO - 'USER': 'cltbld', 07:23:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:53 INFO - 'XPC_FLAGS': '0x0', 07:23:53 INFO - 'XPC_SERVICE_NAME': '0', 07:23:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:53 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:23:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:23:56 INFO - Installing collected packages: mozsystemmonitor 07:23:56 INFO - Running setup.py install for mozsystemmonitor 07:23:56 INFO - Successfully installed mozsystemmonitor 07:23:56 INFO - Cleaning up... 07:23:56 INFO - Return code: 0 07:23:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:23:56 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:23:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:23:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:23:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:23:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:23:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:23:56 INFO - 'HOME': '/Users/cltbld', 07:23:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:23:56 INFO - 'LOGNAME': 'cltbld', 07:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:23:56 INFO - 'MOZ_NO_REMOTE': '1', 07:23:56 INFO - 'NO_EM_RESTART': '1', 07:23:56 INFO - 'PAGER': '/bin/cat', 07:23:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:23:56 INFO - 'PWD': '/builds/slave/test', 07:23:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:23:56 INFO - 'SHELL': '/bin/bash', 07:23:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:23:56 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:23:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:23:56 INFO - 'USER': 'cltbld', 07:23:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:23:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:23:56 INFO - 'XPC_FLAGS': '0x0', 07:23:56 INFO - 'XPC_SERVICE_NAME': '0', 07:23:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:23:56 INFO - Downloading/unpacking jsonschema==2.5.1 07:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:23:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:23:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:23:59 INFO - Downloading functools32-3.2.3-2.tar.gz 07:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:24:00 INFO - warning: no files found matching '*.txt' 07:24:00 INFO - no previously-included directories found matching 'build' 07:24:00 INFO - no previously-included directories found matching 'dist' 07:24:00 INFO - no previously-included directories found matching '.git*' 07:24:00 INFO - Installing collected packages: jsonschema, functools32 07:24:00 INFO - Running setup.py install for functools32 07:24:00 INFO - warning: no files found matching '*.txt' 07:24:00 INFO - no previously-included directories found matching 'build' 07:24:00 INFO - no previously-included directories found matching 'dist' 07:24:00 INFO - no previously-included directories found matching '.git*' 07:24:00 INFO - Successfully installed jsonschema functools32 07:24:00 INFO - Cleaning up... 07:24:00 INFO - Return code: 0 07:24:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:00 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:00 INFO - 'HOME': '/Users/cltbld', 07:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:00 INFO - 'LOGNAME': 'cltbld', 07:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:00 INFO - 'MOZ_NO_REMOTE': '1', 07:24:00 INFO - 'NO_EM_RESTART': '1', 07:24:00 INFO - 'PAGER': '/bin/cat', 07:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:00 INFO - 'PWD': '/builds/slave/test', 07:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:00 INFO - 'SHELL': '/bin/bash', 07:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:24:00 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:00 INFO - 'USER': 'cltbld', 07:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:00 INFO - 'XPC_FLAGS': '0x0', 07:24:00 INFO - 'XPC_SERVICE_NAME': '0', 07:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:24:00 INFO - Cleaning up... 07:24:00 INFO - Return code: 0 07:24:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:00 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:24:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:24:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:24:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:24:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:00 INFO - 'HOME': '/Users/cltbld', 07:24:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:00 INFO - 'LOGNAME': 'cltbld', 07:24:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:00 INFO - 'MOZ_NO_REMOTE': '1', 07:24:00 INFO - 'NO_EM_RESTART': '1', 07:24:00 INFO - 'PAGER': '/bin/cat', 07:24:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:00 INFO - 'PWD': '/builds/slave/test', 07:24:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:00 INFO - 'SHELL': '/bin/bash', 07:24:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:24:00 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:24:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:00 INFO - 'USER': 'cltbld', 07:24:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:00 INFO - 'XPC_FLAGS': '0x0', 07:24:00 INFO - 'XPC_SERVICE_NAME': '0', 07:24:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:00 INFO - Downloading/unpacking blobuploader==1.2.4 07:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:03 INFO - Downloading blobuploader-1.2.4.tar.gz 07:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:24:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:24:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:04 INFO - Downloading docopt-0.6.1.tar.gz 07:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:24:04 INFO - Installing collected packages: blobuploader, requests, docopt 07:24:04 INFO - Running setup.py install for blobuploader 07:24:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:24:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:24:04 INFO - Running setup.py install for requests 07:24:05 INFO - Running setup.py install for docopt 07:24:05 INFO - Successfully installed blobuploader requests docopt 07:24:05 INFO - Cleaning up... 07:24:05 INFO - Return code: 0 07:24:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:05 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:24:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:24:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:24:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:24:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:05 INFO - 'HOME': '/Users/cltbld', 07:24:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:05 INFO - 'LOGNAME': 'cltbld', 07:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:05 INFO - 'MOZ_NO_REMOTE': '1', 07:24:05 INFO - 'NO_EM_RESTART': '1', 07:24:05 INFO - 'PAGER': '/bin/cat', 07:24:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:05 INFO - 'PWD': '/builds/slave/test', 07:24:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:05 INFO - 'SHELL': '/bin/bash', 07:24:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:24:05 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:24:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:05 INFO - 'USER': 'cltbld', 07:24:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:05 INFO - 'XPC_FLAGS': '0x0', 07:24:05 INFO - 'XPC_SERVICE_NAME': '0', 07:24:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:24:05 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-c8G1ep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-xInZoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-_mb2wT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-XBNINn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-6nMOv8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-xwA6dR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-wdpq3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-1r1Z_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-SgAuUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-H3Rrez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:24:06 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-6necS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:24:07 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-zJj_Ge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:24:07 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-A6R33a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:24:07 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-xmU2yJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:07 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-W3_4a8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:24:07 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-a7w2Fb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:24:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:24:07 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-6tLpbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:24:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:24:07 INFO - Running setup.py install for manifestparser 07:24:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:24:07 INFO - Running setup.py install for mozcrash 07:24:07 INFO - Running setup.py install for mozdebug 07:24:08 INFO - Running setup.py install for mozdevice 07:24:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:24:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:24:08 INFO - Running setup.py install for mozfile 07:24:08 INFO - Running setup.py install for mozhttpd 07:24:08 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:24:08 INFO - Running setup.py install for mozinfo 07:24:08 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:24:08 INFO - Running setup.py install for mozInstall 07:24:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:24:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:24:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:24:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:24:08 INFO - Running setup.py install for mozleak 07:24:09 INFO - Running setup.py install for mozlog 07:24:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:24:09 INFO - Running setup.py install for moznetwork 07:24:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:24:09 INFO - Running setup.py install for mozprocess 07:24:09 INFO - Running setup.py install for mozprofile 07:24:09 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:24:09 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:24:09 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:24:09 INFO - Running setup.py install for mozrunner 07:24:09 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:24:09 INFO - Running setup.py install for mozscreenshot 07:24:09 INFO - Running setup.py install for moztest 07:24:10 INFO - Running setup.py install for mozversion 07:24:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:24:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:24:10 INFO - Cleaning up... 07:24:10 INFO - Return code: 0 07:24:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:24:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:10 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:24:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:24:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:24:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:24:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:10 INFO - 'HOME': '/Users/cltbld', 07:24:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:10 INFO - 'LOGNAME': 'cltbld', 07:24:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:10 INFO - 'MOZ_NO_REMOTE': '1', 07:24:10 INFO - 'NO_EM_RESTART': '1', 07:24:10 INFO - 'PAGER': '/bin/cat', 07:24:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:10 INFO - 'PWD': '/builds/slave/test', 07:24:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:10 INFO - 'SHELL': '/bin/bash', 07:24:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:24:10 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:24:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:10 INFO - 'USER': 'cltbld', 07:24:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:10 INFO - 'XPC_FLAGS': '0x0', 07:24:10 INFO - 'XPC_SERVICE_NAME': '0', 07:24:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:24:10 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-TlffK5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:24:10 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-224YVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:24:10 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-X_feuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:24:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:24:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:24:10 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-6MFxme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:24:11 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-rhi0BE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:24:11 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-3egv7X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:24:11 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-7j63XS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:24:11 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-UOsu1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:24:11 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-yBV7zp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:24:11 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-xjfEzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:24:11 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-zrMsLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:24:11 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-mjyFon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:24:11 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-BCjbS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:24:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:24:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:24:12 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-EGtJbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:12 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-iNgbs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:24:12 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-E4NHp7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:24:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:24:12 INFO - Running setup.py (path:/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/pip-lDfmeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:24:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:24:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:24:14 INFO - Downloading blessings-1.6.tar.gz 07:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:24:15 INFO - Installing collected packages: blessings 07:24:15 INFO - Running setup.py install for blessings 07:24:15 INFO - Successfully installed blessings 07:24:15 INFO - Cleaning up... 07:24:15 INFO - Return code: 0 07:24:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:24:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:24:15 INFO - Reading from file tmpfile_stdout 07:24:15 INFO - Current package versions: 07:24:15 INFO - blessings == 1.6 07:24:15 INFO - blobuploader == 1.2.4 07:24:15 INFO - docopt == 0.6.1 07:24:15 INFO - functools32 == 3.2.3-2 07:24:15 INFO - jsonschema == 2.5.1 07:24:15 INFO - manifestparser == 1.1 07:24:15 INFO - mozInstall == 1.12 07:24:15 INFO - mozcrash == 1.0 07:24:15 INFO - mozdebug == 0.1 07:24:15 INFO - mozdevice == 0.49 07:24:15 INFO - mozfile == 1.2 07:24:15 INFO - mozhttpd == 0.7 07:24:15 INFO - mozinfo == 0.9 07:24:15 INFO - mozleak == 0.1 07:24:15 INFO - mozlog == 3.4 07:24:15 INFO - moznetwork == 0.27 07:24:15 INFO - mozprocess == 0.25 07:24:15 INFO - mozprofile == 0.28 07:24:15 INFO - mozrunner == 6.13 07:24:15 INFO - mozscreenshot == 0.1 07:24:15 INFO - mozsystemmonitor == 0.3 07:24:15 INFO - moztest == 0.8 07:24:15 INFO - mozversion == 1.4 07:24:15 INFO - psutil == 3.1.1 07:24:15 INFO - requests == 1.2.3 07:24:15 INFO - wsgiref == 0.1.2 07:24:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:24: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')]} 07:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24: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')]} 07:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:15 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:15 INFO - 'HOME': '/Users/cltbld', 07:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:15 INFO - 'LOGNAME': 'cltbld', 07:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:15 INFO - 'MOZ_NO_REMOTE': '1', 07:24:15 INFO - 'NO_EM_RESTART': '1', 07:24:15 INFO - 'PAGER': '/bin/cat', 07:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:15 INFO - 'PWD': '/builds/slave/test', 07:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:15 INFO - 'SHELL': '/bin/bash', 07:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:24:15 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:15 INFO - 'USER': 'cltbld', 07:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:15 INFO - 'XPC_FLAGS': '0x0', 07:24:15 INFO - 'XPC_SERVICE_NAME': '0', 07:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:24:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:24:15 INFO - Cleaning up... 07:24:15 INFO - Return code: 0 07:24:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:24: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')]} 07:24:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:24:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24: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')]} 07:24:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:24:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:24:15 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 0x101174b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101177768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fee23c845d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, '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.nSfO2OFeSX/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.utpNaEZBVq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:24:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:24:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:24:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:24:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:15 INFO - 'HOME': '/Users/cltbld', 07:24:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:15 INFO - 'LOGNAME': 'cltbld', 07:24:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:15 INFO - 'MOZ_NO_REMOTE': '1', 07:24:15 INFO - 'NO_EM_RESTART': '1', 07:24:15 INFO - 'PAGER': '/bin/cat', 07:24:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:15 INFO - 'PWD': '/builds/slave/test', 07:24:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:15 INFO - 'SHELL': '/bin/bash', 07:24:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:24:15 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:24:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:15 INFO - 'USER': 'cltbld', 07:24:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:15 INFO - 'XPC_FLAGS': '0x0', 07:24:15 INFO - 'XPC_SERVICE_NAME': '0', 07:24:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:24:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:24:16 INFO - Cleaning up... 07:24:16 INFO - Return code: 0 07:24:16 INFO - Running post-action listener: _resource_record_post_action 07:24:16 INFO - Running post-action listener: _start_resource_monitoring 07:24:16 INFO - Starting resource monitoring. 07:24:16 INFO - [mozharness: 2017-02-22 15:24:16.162781Z] Finished create-virtualenv step (success) 07:24:16 INFO - [mozharness: 2017-02-22 15:24:16.163576Z] Running install step. 07:24:16 INFO - Running pre-action listener: _resource_record_pre_action 07:24:16 INFO - Running main action method: install 07:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:24:16 INFO - Reading from file tmpfile_stdout 07:24:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:24:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:24:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:24:16 INFO - Reading from file tmpfile_stdout 07:24:16 INFO - Output received: 07:24:16 INFO - Usage: mozinstall [options] installer 07:24:16 INFO - Options: 07:24:16 INFO - -h, --help show this help message and exit 07:24:16 INFO - -d DEST, --destination=DEST 07:24:16 INFO - Directory to install application into. [default: 07:24:16 INFO - "/builds/slave/test"] 07:24:16 INFO - --app=APP Application being installed. [default: firefox] 07:24:16 INFO - mkdir: /builds/slave/test/build/application 07:24:16 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'] 07:24:16 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 07:24:36 INFO - Reading from file tmpfile_stdout 07:24:36 INFO - Output received: 07:24:36 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:24:36 INFO - Running post-action listener: _resource_record_post_action 07:24:36 INFO - [mozharness: 2017-02-22 15:24:36.799850Z] Finished install step (success) 07:24:36 INFO - [mozharness: 2017-02-22 15:24:36.800049Z] Running run-tests step. 07:24:36 INFO - Running pre-action listener: _resource_record_pre_action 07:24:36 INFO - Running main action method: run_tests 07:24:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:24:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:24:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:24:36 INFO - 2017-02-22 07:24:36.815 screenresolution[1880:8908] starting screenresolution argv=screenresolution get 07:24:36 INFO - 2017-02-22 07:24:36.817 screenresolution[1880:8908] Display 0: 1600x1200x32@60 07:24:36 INFO - 2017-02-22 07:24:36.823 screenresolution[1881:8910] starting screenresolution argv=screenresolution list 07:24:36 INFO - Available Modes on Display 0 07:24:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:24:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:24:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:24:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:24:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:24:37 INFO - Intel Iris: 07:24:37 INFO - Chipset Model: Intel Iris 07:24:37 INFO - Type: GPU 07:24:37 INFO - Bus: Built-In 07:24:37 INFO - VRAM (Dynamic, Max): 1536 MB 07:24:37 INFO - Vendor: Intel (0x8086) 07:24:37 INFO - Device ID: 0x0a2e 07:24:37 INFO - Revision ID: 0x0009 07:24:37 INFO - Displays: 07:24:37 INFO - Display: 07:24:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:24:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:24:37 INFO - Display Serial Number: 1600x1200 60 07:24:37 INFO - Main Display: Yes 07:24:37 INFO - Mirror: Off 07:24:37 INFO - Online: Yes 07:24:37 INFO - Rotation: Supported 07:24:37 INFO - Return code: 0 07:24:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:24:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:24:37 INFO - Python 2.7.3 07:24:37 INFO - Return code: 0 07:24:37 INFO - grabbing minidump binary from tooltool 07:24: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')]} 07:24:37 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 0x100f52d30>, '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 0x100e79db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100f47be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:24:37 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:24:37 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:24:37 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:24:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:24:37 INFO - Return code: 0 07:24:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:24:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:24:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:24:37 INFO - ENV: RUST_BACKTRACE is now 1 07:24:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:24:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:24:37 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/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:24:37 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/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0299 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:24:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.nSfO2OFeSX/Render', 07:24:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:24:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:24:37 INFO - 'HOME': '/Users/cltbld', 07:24:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:24:37 INFO - 'LOGNAME': 'cltbld', 07:24:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:24:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:24:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:24:37 INFO - 'MOZ_NO_REMOTE': '1', 07:24:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:24:37 INFO - 'NO_EM_RESTART': '1', 07:24:37 INFO - 'PAGER': '/bin/cat', 07:24:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:24:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:24:37 INFO - 'PWD': '/builds/slave/test', 07:24:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:24:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:24:37 INFO - 'RUST_BACKTRACE': '1', 07:24:37 INFO - 'SHELL': '/bin/bash', 07:24:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.utpNaEZBVq/Listeners', 07:24:37 INFO - 'TMPDIR': '/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/', 07:24:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:24:37 INFO - 'USER': 'cltbld', 07:24:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:24:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:24:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:24:37 INFO - 'XPC_FLAGS': '0x0', 07:24:37 INFO - 'XPC_SERVICE_NAME': '0', 07:24:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:24:37 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/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0299', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:24:37 INFO - mozversion application_buildid: 20170222053126 07:24:37 INFO - mozversion application_changeset: 8a6084bc234ceb6036af6c660c5162cde5eaf047 07:24:37 INFO - mozversion application_display_name: Nightly 07:24:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:24:37 INFO - mozversion application_name: Firefox 07:24:37 INFO - mozversion application_remotingname: firefox 07:24:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:24:37 INFO - mozversion application_vendor: Mozilla 07:24:37 INFO - mozversion application_version: 54.0a1 07:24:37 INFO - mozversion platform_buildid: 20170222053126 07:24:37 INFO - mozversion platform_changeset: 8a6084bc234ceb6036af6c660c5162cde5eaf047 07:24:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:24:37 INFO - mozversion platform_version: 54.0a1 07:24:37 INFO - using testdate: 1487777077 07:24:37 INFO - actual date: 1487777077 07:24:37 INFO - starting webserver on 'localhost:49369' 07:24:37 INFO - SUITE-START | Running 2 tests 07:24:37 INFO - TEST-START | dromaeo_css 07:24:37 INFO - operating with platform_type : mac_ 07:24:37 INFO - Initialising browser for dromaeo_css test... 07:24:37 INFO - TEST-INFO | started process 1891 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpBTNi1L/profile http://localhost:49369/getInfo.html) 07:24:39 INFO - PROCESS | 1891 | __metrics Screen width/height:1600/1200 07:24:39 INFO - PROCESS | 1891 | colorDepth:24 07:24:39 INFO - PROCESS | 1891 | Browser inner width/height: 1024/689 07:24:39 INFO - PROCESS | 1891 | __metrics 07:24:39 INFO - PROCESS | 1891 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:24:39 INFO - PROCESS | 1891 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:24:40 INFO - TEST-INFO | 1891: exit 0 07:24:40 INFO - Browser initialized. 07:24:40 INFO - Running cycle 1/1 for dromaeo_css test... 07:24:40 INFO - TEST-INFO | started process 1892 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpBTNi1L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:24:52 INFO - PROCESS | 1892 | RSS: Main: 232361984 07:24:52 INFO - PROCESS | 1892 | 07:27:56 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49369/tests/dromaeo/cssquery-ext.html) 07:27:59 INFO - PROCESS | 1892 | RSS: Main: 439566336 07:27:59 INFO - PROCESS | 1892 | 07:29:42 INFO - PROCESS | 1892 | ************************* 07:29:42 INFO - PROCESS | 1892 | A coding exception was thrown and uncaught in a Task. 07:29:42 INFO - PROCESS | 1892 | 07:29:42 ERROR - PROCESS | 1892 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:29:42 INFO - PROCESS | 1892 | Full stack: 07:29:42 INFO - PROCESS | 1892 | ************************* 07:31:02 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-ext.html (next: http://localhost:49369/tests/dromaeo/cssquery-jquery.html) 07:31:03 INFO - PROCESS | 1892 | RSS: Main: 373968896 07:31:03 INFO - PROCESS | 1892 | 07:34:05 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49369/tests/dromaeo/cssquery-mootools.html) 07:34:06 INFO - PROCESS | 1892 | RSS: Main: 346943488 07:34:06 INFO - PROCESS | 1892 | 07:37:08 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49369/tests/dromaeo/cssquery-prototype.html) 07:37:09 INFO - PROCESS | 1892 | RSS: Main: 338755584 07:37:09 INFO - PROCESS | 1892 | 07:40:12 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49369/tests/dromaeo/cssquery-yui.html) 07:40:13 INFO - PROCESS | 1892 | RSS: Main: 350453760 07:40:13 INFO - PROCESS | 1892 | 07:43:16 INFO - PROCESS | 1892 | Cycle 1(1): loaded http://localhost:49369/tests/dromaeo/cssquery-yui.html (next: http://localhost:49369/tests/dromaeo/cssquery-dojo.html) 07:43:17 INFO - PROCESS | 1892 | RSS: Main: 461262848 07:43:17 INFO - PROCESS | 1892 | 07:43:17 INFO - PROCESS | 1892 | __start_tp_report 07:43:17 INFO - PROCESS | 1892 | _x_x_mozilla_page_load 07:43:17 INFO - PROCESS | 1892 | _x_x_mozilla_page_load_details 07:43:17 INFO - PROCESS | 1892 | |i|pagename|runs| 07:43:17 INFO - PROCESS | 1892 | |0;dojo.html;3233.6119665640117;3252.0406480088373;3261.4455542557776;3267.460868956622;3321.352336294422;5166.914947860944;5277.815276465324;5392.164214546741;5442.1020531612285;5506.91739623905;4692.460367057789;5387.380451248107;5405.918911216335;5416.620836541444;5421.349438067437;4925.679830810995;4943.802247910097;4973.179425394806;5017.849464516052;5031.647784655075;4991.825286114987;5085.923711144335;5086.237064440326;5088.4911508849;5097.286379906816;5060.721660308682;5062.417821950486;5063.164577844651;5064.594832413398;5065.265536497206;5066.569341605968;5070.645054846163;5071.873203169914;5072.4166720827025;5074.391073071218;4297.90403447119;4875.24433712775;4991.401031876162;5010.498950104997;5024.422191447957;5291.1534154535475;5541.168824676291;5556.555475561986;5557.305336832896;5560.4161563036105;5976.760929562813;5990.161377407167;5990.580659353847;6006.369331220203;6023.728932198062;5915.024021036524;5922.052471604566;5942.316633587149;5943.286805583314;5994.7901823436405;5575.693336866511;5579.442055794388;5588.357338905997;5610;5626.352969408529;6190.1952746142715;6202.44178023971;6216.347283535254;6218.005119181;6219.378062193744;5638.210650508932;5688.63023903445;5690.0895856663565;5833.679147646835;5879.647221166743;5873.853153671193;5879.853003674857;5895.616784908967;5895.911561326584;5907.7046147692445;5741.081426971665;5825.970870145707;5851.882962340729;5853.443922827325;5862.208601838783;5832.562557808096;5886.6173698709445;5886.735096920649;5893.734781934823;5898.764049437975;4673.602743766818;4703.129920964632;4711.434627844681;4715.080559290974;4722.598579120745;4176.18564379943;4243.830246790156;4256.957430425656;4269.996550810557;4296.226679197712;4599.6090332321455;5436.184572314184;5516.531094856902;5534.252875861707;5579.218909352694;4893.7276308160135;6030.668313242726;6044.365341639153;6047.183630209865;6048;5353.732313384316;5427.565794736412;5513.807016754475;5526.668399896019;5564.165375193672;5170.71561064145;5174.741262936838;5175.767090480937;5177.4822517747925;5192.662476938987;6137.407629318989;6144.692765361803;6153.476954458832;6154.892119418369;6167.105769663463;5864.648121112747;6043.637381757108;6085.513158947362;6113.57204995646;6135.967692822179;6241.563090583615;6246.718897649707;6247.625142491465;6258.906116408349;6269.404406581368;6008.369121242206;6009.008513595382;6014.338422773579;6014.969925150522;6067.24159480065;5775.191473193672;5820.534357251495;5838.503727183237;5921.052631578927;5933.614315069679;5799.478046975623;5816.098504731774;5821.534277257724;5826.329972053268;5855.268091488564;5784.161296611884;5805.274340707411;5807.970960145172;5814.360420353673;5815.41845815415;4404.647628189801;5419.566434685295;5511.5039646432015;5633.0987042073075;5704.916065947456;5712.742926568231;5721.256236689203;5728.914066289092;5736.19693242938;5736.913946290892;5602.215689803349;5615.887682246251;5616.241807355955;5625.803096891589;5631.183478395692 07:43:17 INFO - PROCESS | 1892 | |1;ext.html;425.17728195940856;432.72089502271035;451.42443384684503;475.54347826086956;530.1808705549925;38170.42744358837;40128.79935600322;40204.39693404601;40285.59714402855;40387.79806100973;40832;41199.026141209506;41502;41523.377149342785;41715;7461.179270280292;9203.401778884385;9592.520373981308;9600;9601.47191904445;7482.812929676747;7622.923770762304;7633.6564854581675;7634.083909930816;7636.052806534326;11303.039241664428;11637;11647.475863586116;11750.706232344175;11754.353510556915;11700.765984680302;11750.471228794724;11755.17713760037;11758.588449404315;11764;11278.097752179807;11347.943260283646;11365.318080915089;11385.487653055632;11404.828927566094;27839.721602783917;28464.591727571697;28506.429871402663;28942;29023.564646530318;3102.4570700127388;3767.585565587783;3829.0618798394294;3895.61043895611;3996.86010989614;23802.523949521084;25667;29947.550786738215;30101.548476772867;30203.848980755174;2902.680705122435;3170.8414579270943;3195.121341631047;3225.7580681448985;3232.951505727416;403882;405024;406381;406485;411415.9429202865;57453.42546574481;57599;57796.71101644465;57928.71035644879;57994.04071511361;60379;60754.2660580275;60877.69561152166;60956.39043609507;61001.764761757484;14933.328000240015;15151.848481515044;15204.695906082037;15217.467388641344;15239.314230859638;11723.944844963995;11767.293962362286;11782.410879455992;11785.175037747447;11790.469428875722;12675.683107922192;13090.214587124803;15732.213389330487;15777.921110394374;15959.840401596068;5180.533751962342;6776.796696099125;6870.519063665595;6961.642479716406;6984.580925144406;637.4740838808002;739.8557281330196;837.681680961243;845.6828689241535;846.221476241859;23125.95933183011;26811.865940670174;28387;29036.983705570205;29472;900.5317235037875;1009.6617633092997;1020.7244044108049;1021.8109649714827;1050.417018554694;14141;14231.715365692835;14519.274036298142;14614.561563153122;15037.473688420852;549346;552304.2384788131;552836;553553.4644653583;554173;55704.442955569924;55706;55759.442405576236;55792.442075579536;55889.895965084834;1335.9866401335862;1387.47276035106;1391.7842734376188;1395.5534229046812;1398.349767358163;25491.745082548936;27676.72323276822;28075;28088.06767052655;28658.57012144861;47192.29211561898;47828.76085619689;47834.76082619565;47883.80290492765;47935.28097078617;470538;472162;472437;473133.6343318261;473400;36580.90257292285;37459.43810842785;37673.81163094167;37764.62235377611;37769.433458497595;43554.34668479912;44423.777881110385;44507.332390014824;45019.54980450284;45070;29614.815407383463;32528.674713252563;33254.33491330208;35903.28193436169;37476.06309842276;35340.823295883354;35536;35636.287274254886;37153;37264.44103338398;34276;34537.827310863286;34537.82731086429;36236.4564531527;36502.26995460129;30748.923787667325;31646.208844779063;32326.676733233307;32400.027999160062;32408.83795581007;22608.660870086635;23588.52822943566;24086.75913240915;24439;24549.263522094367 07:43:17 INFO - PROCESS | 1892 | |2;jquery.html;323.4113912678924;355.8612141264909;387.1772483472621;394.84995701633386;417.8433087592153;13768.724625507484;14036.368363423644;14659.706805863889;20760.169593216255;21565.029573669184;20932.37202883912;21810.127594896185;22391.888040559814;22589.54820903581;22600.88699556504;5874.5594080443925;5924.763009479616;6087.05650624154;6204.472619827297;6206.565540412173;3874.651281384675;6047.7278522466595;6167.938320616804;6168.84577885552;6169.598976066563;4036.777977211252;4067.755934643916;4102.261592913274;4107.876763697094;4113.465249517573;6637.369449902251;6729.5625784323865;6732.518845853904;6734.595924244561;6742;4627.259638457831;5646.774129034875;5854.47309742121;5930.495907847838;5957.821265362046;20865.165393384246;26645.06742264031;26765;26923.865380673167;27301.726982730117;3073.339232065094;3113.641931177898;3148.590683211191;3179.0462861141564;3256.0069178900426;15264.923675381662;15922.363105475768;16037.278322475517;16046.75929861053;16069.678606427922;1805.7201133824278;1823.216017112641;1845.6157881588808;1861.2909339371413;1921.6637088509456;118866;122465;125910;126416;127637.99999999907;10501.264911456125;10504.527296271686;11316.377599231957;11513;12025.879741202476;14901.701965960838;14926.776098358534;14933.40266389354;14937.850621493862;14958.70082598342;8143.552104634184;8414.284785793276;8440.412824549665;8612.913870861337;8622.568871556397;7142.21435642079;8178.263956243966;8220.671173153127;8374.246317831425;8383;6731.764388246388;7294.088238970129;7294.8905766413545;7296.598687072262;7303.196648368676;1918.539550507896;1955.4720225539024;1956.8825870447818;1958.1286327584373;1959.5395082155683;1022.7187523431116;1029.7219750667277;1043.7912417516527;1061.808874402615;1115.8884111588777;22474.88762556177;22685.659715104288;22890.771092289197;22942.082316707143;23022.539549209258;1054.3779170289565;1063.1707268330715;1080.7622323088908;1081.3986487495656;1094.1684319916922;11716.765664686658;11728.061755059574;11820.113491488173;12063.573747129953;12110.333931633668;668340;676392;676591;689643;696373;84448;121516.39241803734;123899.14151287738;125390;129036;1033.3593172233113;1036.2176556699644;1072.222638587018;1078.6386560502162;1079.5465904320204;16896.746548802024;19538.706919395936;19949.60100797947;19992.90003549973;20030.799692002893;46414.30378544392;51283.74358128185;52761;53540.46459535511;54082.45917540774;66223;75584;78266.82599760895;79198;79223;7366.7053317866685;7722.961385193038;7936.365090792608;7992.240737129963;8506.61720222579;12742.08868669707;13308.001899857743;13319.600411987656;13804.654883627989;13809.51666691661;11372.54509819598;11380.54477820878;11611.593594224161;11777.587784427504;11794;11319.434028298718;11354.318740875575;11519;11665.300081995107;11752.059835213333;11652.708682283012;11849.111316651459;12005.75988480243;12037.638870833889;12060.276383416673;7507.099148102263;7547.396208303432;7793.844123117619;8014.559199244098;8080.63637136342;11255.549778008788;11324.207305488537;11661.300321980709;11687;11712.238704484182 07:43:17 INFO - PROCESS | 1892 | |3;mootools.html;1356.9592912212634;1410.1609542322321;1432.126402894235;1446.1756798624774;1459.5621313605918;8124.959375203123;8533.743987680371;8549.61526731297;8562.015368232655;8589.527575983318;8110.432269741121;8450.323974082074;8464;8545.27365173961;8550.230479256865;2271.23913488981;2310.4685922237895;2313.641385585237;2316.3861576682193;2317.9536409271805;1845.6862333403287;2270.3529494094187;2321.5589038082794;2332.346942856003;2335.2760644200353;1987.8707883987568;2019.515316324079;2019.6970454431805;2020.8282296004857;2021.757389113301;1638.5985433568792;2182.9563408731815;2261.3894248552965;2265.8980345884474;2268.7164104486938;1908.2271679969635;1923.7691477022847;2295.070496448941;2303.2859813457712;2313.5835549601065;7348.559086454777;8435.072142064368;8515.105913879015;8519.53142577158;8523.488590684517;4572.634189264884;4764.499727528629;4766.451858036336;4770.833020844254;4773.093112308685;3388.576797744928;3408.0164030695955;3518.4194607889667;3519.5776506819348;3583.910402239939;1194.331174542259;1208.172401904698;1237.412229191136;1247.5321754342121;1254.0406588959454;10686.305390149615;10725.946370268099;10810.513526891387;10821.188410869216;10823.783524329549;4205.957940420618;4301.118270754488;4430.224710675619;4446.487734430101;4481.1933851906315;7767.961160194276;8359.958200209081;8750.212480876751;8762.299016078698;8766.780830479289;5123;5123.436421993578;5128.769205385766;5129.179331306973;5131.589472842164;4645.837395691202;4684.929726054112;4742.715437073786;4810.759462026885;4868.9269660955115;3498.2828520153307;3536.3104194682305;3563.1626567757075;3605.6214097519905;3624.5469316335457;1127.8308253762002;1130.2483848240827;1135.6933627920416;1145.73075327298;1147.0651419093579;827.1563005734117;854.4702284583474;857.9914200857911;902.7833320003152;913.1735779119907;5372.274742909735;5541.556675465953;5586.273784408001;5780.479756821906;5812.686768541975;952.8237276103804;953.3660116022905;968.0029569543382;993.7217579077869;1021.4126877045728;3560.181158333546;3591.6049234584175;3699.2416554606243;3764.284785890672;3811.7712937223855;9779.070988256246;10077.09306162449;10080.697579072494;10099.848502272473;10103.242256830767;9468.100530449734;9890.60437582503;9915.900840991642;9924.206063514901;10055.145312648361;7552.433567482351;7807.258310460497;7819.732277639535;7822.335101516321;7826.608669566613;4938.2839488273285;5473.945260547343;5486.341639003185;5784.623999440023;5798.304203495608;7485.7754267372065;9233.907660923305;9235.861462077939;9303;9318.48748318849;7635.885461717968;9219.216366608645;9386.436813791195;9410.764730881509;9455.05449455049;6706.765263215764;7032.367086962198;7125.18060423058;7271.163816160997;7278.490505664553;7743.380529557735;7897.565633890191;7911.367090632621;7918.643661035382;7919.604019798871;6876.312368763083;7034.613096279753;7051.964740176266;7129.750458733919;7134.215236324104;6925.20360158568;6936.237013928565;6953.582785032914;7019.122609673791;7057.988473285089;6101.786437474667;6242.344553821965;6289.465395441439;6329.556931014785;6336.936630633634;4186.413902053776;4810.5670489656095;4832;4925.950740492549;5005.899882002413;4085.4280400744515;4865.854024379274;4943.2585112233455;4993.15116430215;5055.51972562606 07:43:17 INFO - PROCESS | 1892 | |4;prototype.html;300.9466865969108;355;365.2694610778443;367.3479573756583;369.11596725841594;4605.5624715652;5191.299174611427;5232.4505926877655;5242.7640756165965;5282.841514754554;4056.918861622773;4905.803767849291;5158.375111839768;5197.740112994354;5211.973940130294;3523.9823800881086;3977.2840888640035;3990.381490868913;4007.7194596378267;4015.176888737816;3315.1214928044087;4029.629925825219;4044.8786536403954;4048.7773172475504;4052.898677533056;3662.780233186004;3912.9630647878193;3994.3609022556398;4045.858394956177;4052.837886484537;3901.581019767734;3929.7445666031617;3931;3942.1918506706056;3955.3671412573995;2921.5033444314518;3413.5050417689545;3421.9315613687586;3464.532288141094;3484.5818501779695;4390.05613793036;4914.827981020647;5083.822066227664;5092.955944031464;5105.463926287724;3594.658507441815;4450.421445212101;4524.502304746476;4537.455505339348;4555.838261243362;5249.895002099936;5472.206530053159;5503.3120859892515;5519.558435325164;5536.750846211889;3782.8108594570162;3788.5643151037707;3794.2411517696573;3809.1810260794064;3833.5591406988274;5479.3972862890205;5679.176519404663;5731.512821410143;5742.019003443847;5759.452851979056;3829.215010922754;3836.5396152461326;3841.961580384216;3848.978551836795;3854.6338097881217;3310.93378132436;3934;3935.5474120475938;3948.2103579284258;3963.1677347756718;3440.7935523868646;4291.485021797404;4505.008898042425;4510.66170037242;4570.977145114253;5546.77812887488;5548.389677135512;5552.888942221133;5558.138488534284;5560.944390556043;1157.8031734605138;1189.9821502677466;1242.5402601037492;1255.1966741285585;1264.0709078827056;713.8286811165283;846.7425872579215;852.3394369363792;864.6843901975859;873.7946582553095;4210.789460526961;4346.2842815544855;4406.9559304407185;4620.584147426748;4663.160631086437;5398.784048638089;5451.781928722886;5461.579989202836;5474.315710536183;5576.498115169654;4094.4677191965447;4715.108346017676;4874.19654727753;4897.461279259279;4903.828366007173;2450.4363996280954;2497.875106244717;2732.4808286425514;2841.5311473606625;2887.826730396183;4862.465128835825;5249.790008399697;5475.534579560782;5583.553315734732;5688.63023903445;5230.895382092337;5501.669899806025;5523.4200408956485;5552.7223638817895;5576.637518561281;4924.556789888856;5026.447090820006;5300.257963884982;5533.446655334435;5545.362283337387;4315.331123675835;4894.115765430406;5363.839084827461;5421.268128802719;5427.402985671652;4628.930566041579;4639.930401043919;4944.53026962438;5308.575313974796;5342.6260161788305;4654.069186162713;5009.323741295024;5067.719526213293;5573.804916827891;5652.095664693629;3178.3154927888254;3309.9007029789145;3625.2749450109554;3667.7982710951155;3677.44838274261;4909.312696222603;4924.704517728947;4990.4011518618;5042.369703787027;5468.316460442445;5145;5220.817271395483;5223.817166399158;5227.89544209106;5275.916013174698;4650.34895114691;4910.950890491193;4925.128451188669;5210.426853046238;5220.791168353223;4506.439912469113;4649.3955785748985;5110.565601923878;5135.794568217229;5169.216620266002;4546.727196368229;4936.358273424576;5218.921716174336;5251.684898906078;5327.493888080626;4499.212637788309;5093.745312734422;5106.6338280769405;5117.385913690232;5163.586913047023 07:43:17 INFO - PROCESS | 1892 | |5;yui.html;743.3124359967029;765.9731909383173;772.1236396689756;788.3850596534702;803.6263137640996;14323.64190895228;15241.314140863687;15247.237638118106;15291.235438228072;15357.385704571818;13794.448222071105;13911.860881391183;13917;13924.373403196854;13954.092983956036;881.5548148185158;891.5408564589242;907.2605826251583;911.1935936696038;918.609590923858;906.6917248135633;927.5872236854602;928.512530921265;928.7770934975591;928.8281667891462;949.3781573069616;951.6859436386011;951.7953639967405;954.4750387286999;957.6887511558771;946.3186505715873;946.8627049077915;947.2232769129316;947.3415975896754;948.1987720376305;704.8167476456107;704.89426586012;704.9189343225493;705.7882635209417;706.9081019467487;15002.24988750569;15262.847371526253;15475.994060386152;15504.379824806994;15507.379704811794;13589.796153057712;13764.449422023106;13772.173669579857;13961.930190349085;13967.930160349235;10862.511186996604;11309.886901130965;11430.542778288858;11660.475278612483;12116.09129315305;4354.738715677069;4386.342048692722;4417.076439435819;4418.668599855024;4584.7478388688605;78342.21657783464;81792.59103704443;82842.17157828405;105329.47335263352;106398.93601063968;10572.52423640938;10825.783484330426;10842.186835987333;11119.533498808518;11267.323960562393;21807;21967.23114690978;22027.33917982463;22128;22149.114035438724;7371.852562948711;7678.424118191158;7731.613419329011;7800.765977020698;7975.202479751978;4190.308599081118;4209.221294060609;4242.0294107408035;4342.9782851086175;4368.5194628590825;3305.190228394011;3510.5606701252364;3621.80080095592;3729.272791805626;3731.869384571527;675.6689222281046;695.8434352270699;696.6690821859678;698.7205117952859;705.3475535129984;493.60758197233287;623.099621047591;625.7215539085155;627.2222444169197;699.4020112803581;9323.860142097874;9768.462734549526;9958.253131015057;9979;10063.062658218274;374.4383424862706;456.24263722220957;505.8861756104847;591.9256549362979;687.4294335701455;3731.4402839573736;4866.270059491034;4936.3829521309835;5004.992012779524;5206.873589950017;84037;99275.01449971105;100607.99392006133;101447.49276253571;105598;46937.765311173906;61299.69350153221;74354.62822685852;75212.62393687997;90444;59985;71622.49321273835;73397;73614;73763.63118184482;9954.55204515784;10293.639722609973;10299.639512617023;10421.895781042396;10442.843357349799;47715.284270735276;47976.52023479721;48382.516174839206;49437.25844112269;50362.46012938647;52670.68323291948;60986;61092.778144437754;63825.08524744265;65649.35876603123;12132.454039568063;12152.515872500402;12171.573994910135;12314.322712250912;12411.31737754396;13539.59381218565;13718.24549649739;13738.65653358674;13803.861961380258;14480.420783168976;12532;12653.493860245855;12817.551385701456;12856.55002074923;13134.146280491737;12624.74750505003;12789.93605031969;12946;13201.60395188146;13294.734105318033;12097.274163550215;12535.310557919402;12543.811842822182;12961.675958101123;13205.943524517823;10340.948295258475;10629.468526573795;10699.732506687084;10748.355098694103;11209.887901120885;6985.5808651481075;8506.319494440553;10160.542775575264;10193.184545236512;10196.490175491344 07:43:17 INFO - PROCESS | 1892 | __end_tp_report 07:43:17 INFO - PROCESS | 1892 | __start_cc_report 07:43:17 INFO - PROCESS | 1892 | _x_x_mozilla_cycle_collect,2635 07:43:17 INFO - PROCESS | 1892 | __end_cc_report 07:43:17 INFO - PROCESS | 1892 | __startTimestamp1487778197209__endTimestamp 07:43:17 INFO - PROCESS | 1892 | 07:43:17 INFO - PROCESS | 1892 | ------- Summary: start ------- 07:43:17 INFO - PROCESS | 1892 | Number of tests: 6 07:43:17 INFO - PROCESS | 1892 | 07:43:17 INFO - PROCESS | 1892 | [#0] dojo.html Cycles:165 Average:5481.84 Median:5626.35 stddev:628.28 (11.2%) stddev-sans-first:604.95 07:43:17 INFO - PROCESS | 1892 | Values: 3233.6 3252.0 3261.4 3267.5 3321.4 5166.9 5277.8 5392.2 5442.1 5506.9 4692.5 5387.4 5405.9 5416.6 5421.3 4925.7 4943.8 4973.2 5017.8 5031.6 4991.8 5085.9 5086.2 5088.5 5097.3 5060.7 5062.4 5063.2 5064.6 5065.3 5066.6 5070.6 5071.9 5072.4 5074.4 4297.9 4875.2 4991.4 5010.5 5024.4 5291.2 5541.2 5556.6 5557.3 5560.4 5976.8 5990.2 5990.6 6006.4 6023.7 5915.0 5922.1 5942.3 5943.3 5994.8 5575.7 5579.4 5588.4 5610.0 5626.4 6190.2 6202.4 6216.3 6218.0 6219.4 5638.2 5688.6 5690.1 5833.7 5879.6 5873.9 5879.9 5895.6 5895.9 5907.7 5741.1 5826.0 5851.9 5853.4 5862.2 5832.6 5886.6 5886.7 5893.7 5898.8 4673.6 4703.1 4711.4 4715.1 4722.6 4176.2 4243.8 4257.0 4270.0 4296.2 4599.6 5436.2 5516.5 5534.3 5579.2 4893.7 6030.7 6044.4 6047.2 6048.0 5353.7 5427.6 5513.8 5526.7 5564.2 5170.7 5174.7 5175.8 5177.5 5192.7 6137.4 6144.7 6153.5 6154.9 6167.1 5864.6 6043.6 6085.5 6113.6 6136.0 6241.6 6246.7 6247.6 6258.9 6269.4 6008.4 6009.0 6014.3 6015.0 6067.2 5775.2 5820.5 5838.5 5921.1 5933.6 5799.5 5816.1 5821.5 5826.3 5855.3 5784.2 5805.3 5808.0 5814.4 5815.4 4404.6 5419.6 5511.5 5633.1 5704.9 5712.7 5721.3 5728.9 5736.2 5736.9 5602.2 5615.9 5616.2 5625.8 5631.2 07:43:17 INFO - PROCESS | 1892 | 07:43:17 INFO - PROCESS | 1892 | [#1] ext.html Cycles:180 Average:61487.27 Median:36369.36 stddev:127991.75 (351.9%) stddev-sans-first:128268.69 07:43:17 INFO - PROCESS | 1892 | Values: 425.2 432.7 451.4 475.5 530.2 38170.4 40128.8 40204.4 40285.6 40387.8 40832.0 41199.0 41502.0 41523.4 41715.0 7461.2 9203.4 9592.5 9600.0 9601.5 7482.8 7622.9 7633.7 7634.1 7636.1 11303.0 11637.0 11647.5 11750.7 11754.4 11700.8 11750.5 11755.2 11758.6 11764.0 11278.1 11347.9 11365.3 11385.5 11404.8 27839.7 28464.6 28506.4 28942.0 29023.6 3102.5 3767.6 3829.1 3895.6 3996.9 23802.5 25667.0 29947.6 30101.5 30203.8 2902.7 3170.8 3195.1 3225.8 3233.0 403882.0 405024.0 406381.0 406485.0 411415.9 57453.4 57599.0 57796.7 57928.7 57994.0 60379.0 60754.3 60877.7 60956.4 61001.8 14933.3 15151.8 15204.7 15217.5 15239.3 11723.9 11767.3 11782.4 11785.2 11790.5 12675.7 13090.2 15732.2 15777.9 15959.8 5180.5 6776.8 6870.5 6961.6 6984.6 637.5 739.9 837.7 845.7 846.2 23126.0 26811.9 28387.0 29037.0 29472.0 900.5 1009.7 1020.7 1021.8 1050.4 14141.0 14231.7 14519.3 14614.6 15037.5 549346.0 552304.2 552836.0 553553.5 554173.0 55704.4 55706.0 55759.4 55792.4 55889.9 1336.0 1387.5 1391.8 1395.6 1398.3 25491.7 27676.7 28075.0 28088.1 28658.6 47192.3 47828.8 47834.8 47883.8 47935.3 470538.0 472162.0 472437.0 473133.6 473400.0 36580.9 37459.4 37673.8 37764.6 37769.4 43554.3 44423.8 44507.3 45019.5 45070.0 29614.8 32528.7 33254.3 35903.3 37476.1 35340.8 35536.0 35636.3 37153.0 37264.4 34276.0 34537.8 34537.8 36236.5 36502.3 30748.9 31646.2 32326.7 32400.0 32408.8 22608.7 23588.5 24086.8 24439.0 24549.3 07:43:17 INFO - PROCESS | 1892 | 07:43:17 INFO - PROCESS | 1892 | [#2] jquery.html Cycles:180 Average:37460.49 Median:21687.58 stddev:112871.19 (520.4%) stddev-sans-first:113153.38 07:43:17 INFO - PROCESS | 1892 | Values: 323.4 355.9 387.2 394.8 417.8 13768.7 14036.4 14659.7 20760.2 21565.0 20932.4 21810.1 22391.9 22589.5 22600.9 5874.6 5924.8 6087.1 6204.5 6206.6 3874.7 6047.7 6167.9 6168.8 6169.6 4036.8 4067.8 4102.3 4107.9 4113.5 6637.4 6729.6 6732.5 6734.6 6742.0 4627.3 5646.8 5854.5 5930.5 5957.8 20865.2 26645.1 26765.0 26923.9 27301.7 3073.3 3113.6 3148.6 3179.0 3256.0 15264.9 15922.4 16037.3 16046.8 16069.7 1805.7 1823.2 1845.6 1861.3 1921.7 118866.0 122465.0 125910.0 126416.0 127638.0 10501.3 10504.5 11316.4 11513.0 12025.9 14901.7 14926.8 14933.4 14937.9 14958.7 8143.6 8414.3 8440.4 8612.9 8622.6 7142.2 8178.3 8220.7 8374.2 8383.0 6731.8 7294.1 7294.9 7296.6 7303.2 1918.5 1955.5 1956.9 1958.1 1959.5 1022.7 1029.7 1043.8 1061.8 1115.9 22474.9 22685.7 22890.8 22942.1 23022.5 1054.4 1063.2 1080.8 1081.4 1094.2 11716.8 11728.1 11820.1 12063.6 12110.3 668340.0 676392.0 676591.0 689643.0 696373.0 84448.0 121516.4 123899.1 125390.0 129036.0 1033.4 1036.2 1072.2 1078.6 1079.5 16896.7 19538.7 19949.6 19992.9 20030.8 46414.3 51283.7 52761.0 53540.5 54082.5 66223.0 75584.0 78266.8 79198.0 79223.0 7366.7 7723.0 7936.4 7992.2 8506.6 12742.1 13308.0 13319.6 13804.7 13809.5 11372.5 11380.5 11611.6 11777.6 11794.0 11319.4 11354.3 11519.0 11665.3 11752.1 11652.7 11849.1 12005.8 12037.6 12060.3 7507.1 7547.4 7793.8 8014.6 8080.6 11255.5 11324.2 11661.3 11687.0 11712.2 07:43:17 INFO - PROCESS | 1892 | 07:43:17 INFO - PROCESS | 1892 | [#3] mootools.html Cycles:180 Average:5335.14 Median:5030.71 stddev:2947.66 (58.6%) stddev-sans-first:2940.77 07:43:17 INFO - PROCESS | 1892 | Values: 1357.0 1410.2 1432.1 1446.2 1459.6 8125.0 8533.7 8549.6 8562.0 8589.5 8110.4 8450.3 8464.0 8545.3 8550.2 2271.2 2310.5 2313.6 2316.4 2318.0 1845.7 2270.4 2321.6 2332.3 2335.3 1987.9 2019.5 2019.7 2020.8 2021.8 1638.6 2183.0 2261.4 2265.9 2268.7 1908.2 1923.8 2295.1 2303.3 2313.6 7348.6 8435.1 8515.1 8519.5 8523.5 4572.6 4764.5 4766.5 4770.8 4773.1 3388.6 3408.0 3518.4 3519.6 3583.9 1194.3 1208.2 1237.4 1247.5 1254.0 10686.3 10725.9 10810.5 10821.2 10823.8 4206.0 4301.1 4430.2 4446.5 4481.2 7768.0 8360.0 8750.2 8762.3 8766.8 5123.0 5123.4 5128.8 5129.2 5131.6 4645.8 4684.9 4742.7 4810.8 4868.9 3498.3 3536.3 3563.2 3605.6 3624.5 1127.8 1130.2 1135.7 1145.7 1147.1 827.2 854.5 858.0 902.8 913.2 5372.3 5541.6 5586.3 5780.5 5812.7 952.8 953.4 968.0 993.7 1021.4 3560.2 3591.6 3699.2 3764.3 3811.8 9779.1 10077.1 10080.7 10099.8 10103.2 9468.1 9890.6 9915.9 9924.2 10055.1 7552.4 7807.3 7819.7 7822.3 7826.6 4938.3 5473.9 5486.3 5784.6 5798.3 7485.8 9233.9 9235.9 9303.0 9318.5 7635.9 9219.2 9386.4 9410.8 9455.1 6706.8 7032.4 7125.2 7271.2 7278.5 7743.4 7897.6 7911.4 7918.6 7919.6 6876.3 7034.6 7052.0 7129.8 7134.2 6925.2 6936.2 6953.6 7019.1 7058.0 6101.8 6242.3 6289.5 6329.6 6336.9 4186.4 4810.6 4832.0 4926.0 5005.9 4085.4 4865.9 4943.3 4993.2 5055.5 07:43:17 INFO - PROCESS | 1892 | 07:43:17 INFO - PROCESS | 1892 | [#4] prototype.html Cycles:180 Average:4319.05 Median:4884.16 stddev:1305.62 (26.7%) stddev-sans-first:1273.97 07:43:17 INFO - PROCESS | 1892 | Values: 300.9 355.0 365.3 367.3 369.1 4605.6 5191.3 5232.5 5242.8 5282.8 4056.9 4905.8 5158.4 5197.7 5212.0 3524.0 3977.3 3990.4 4007.7 4015.2 3315.1 4029.6 4044.9 4048.8 4052.9 3662.8 3913.0 3994.4 4045.9 4052.8 3901.6 3929.7 3931.0 3942.2 3955.4 2921.5 3413.5 3421.9 3464.5 3484.6 4390.1 4914.8 5083.8 5093.0 5105.5 3594.7 4450.4 4524.5 4537.5 4555.8 5249.9 5472.2 5503.3 5519.6 5536.8 3782.8 3788.6 3794.2 3809.2 3833.6 5479.4 5679.2 5731.5 5742.0 5759.5 3829.2 3836.5 3842.0 3849.0 3854.6 3310.9 3934.0 3935.5 3948.2 3963.2 3440.8 4291.5 4505.0 4510.7 4571.0 5546.8 5548.4 5552.9 5558.1 5560.9 1157.8 1190.0 1242.5 1255.2 1264.1 713.8 846.7 852.3 864.7 873.8 4210.8 4346.3 4407.0 4620.6 4663.2 5398.8 5451.8 5461.6 5474.3 5576.5 4094.5 4715.1 4874.2 4897.5 4903.8 2450.4 2497.9 2732.5 2841.5 2887.8 4862.5 5249.8 5475.5 5583.6 5688.6 5230.9 5501.7 5523.4 5552.7 5576.6 4924.6 5026.4 5300.3 5533.4 5545.4 4315.3 4894.1 5363.8 5421.3 5427.4 4628.9 4639.9 4944.5 5308.6 5342.6 4654.1 5009.3 5067.7 5573.8 5652.1 3178.3 3309.9 3625.3 3667.8 3677.4 4909.3 4924.7 4990.4 5042.4 5468.3 5145.0 5220.8 5223.8 5227.9 5275.9 4650.3 4911.0 4925.1 5210.4 5220.8 4506.4 4649.4 5110.6 5135.8 5169.2 4546.7 4936.4 5218.9 5251.7 5327.5 4499.2 5093.7 5106.6 5117.4 5163.6 07:43:17 INFO - PROCESS | 1892 | 07:43:17 INFO - PROCESS | 1892 | [#5] yui.html Cycles:180 Average:18827.76 Median:4377.43 stddev:26149.06 (597.4%) stddev-sans-first:26187.15 07:43:17 INFO - PROCESS | 1892 | Values: 743.3 766.0 772.1 788.4 803.6 14323.6 15241.3 15247.2 15291.2 15357.4 13794.4 13911.9 13917.0 13924.4 13954.1 881.6 891.5 907.3 911.2 918.6 906.7 927.6 928.5 928.8 928.8 949.4 951.7 951.8 954.5 957.7 946.3 946.9 947.2 947.3 948.2 704.8 704.9 704.9 705.8 706.9 15002.2 15262.8 15476.0 15504.4 15507.4 13589.8 13764.4 13772.2 13961.9 13967.9 10862.5 11309.9 11430.5 11660.5 12116.1 4354.7 4386.3 4417.1 4418.7 4584.7 78342.2 81792.6 82842.2 105329.5 106398.9 10572.5 10825.8 10842.2 11119.5 11267.3 21807.0 21967.2 22027.3 22128.0 22149.1 7371.9 7678.4 7731.6 7800.8 7975.2 4190.3 4209.2 4242.0 4343.0 4368.5 3305.2 3510.6 3621.8 3729.3 3731.9 675.7 695.8 696.7 698.7 705.3 493.6 623.1 625.7 627.2 699.4 9323.9 9768.5 9958.3 9979.0 10063.1 374.4 456.2 505.9 591.9 687.4 3731.4 4866.3 4936.4 5005.0 5206.9 84037.0 99275.0 100608.0 101447.5 105598.0 46937.8 61299.7 74354.6 75212.6 90444.0 59985.0 71622.5 73397.0 73614.0 73763.6 9954.6 10293.6 10299.6 10421.9 10442.8 47715.3 47976.5 48382.5 49437.3 50362.5 52670.7 60986.0 61092.8 63825.1 65649.4 12132.5 12152.5 12171.6 12314.3 12411.3 13539.6 13718.2 13738.7 13803.9 14480.4 12532.0 12653.5 12817.6 12856.6 13134.1 12624.7 12789.9 12946.0 13201.6 13294.7 12097.3 12535.3 12543.8 12961.7 13205.9 10340.9 10629.5 10699.7 10748.4 11209.9 6985.6 8506.3 10160.5 10193.2 10196.5 07:43:17 INFO - PROCESS | 1892 | -------- Summary: end -------- 07:43:17 INFO - PROCESS | 1892 | 07:43:17 INFO - TEST-INFO | 1892: exit 0 07:43:17 INFO - TEST-OK | dromaeo_css | took 1120514ms 07:43:17 INFO - TEST-START | kraken 07:43:17 INFO - operating with platform_type : mac_ 07:43:17 INFO - Initialising browser for kraken test... 07:43:17 INFO - TEST-INFO | started process 1899 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpWD1IvF/profile http://localhost:49369/getInfo.html) 07:43:20 INFO - PROCESS | 1899 | __metrics Screen width/height:1600/1200 07:43:20 INFO - PROCESS | 1899 | colorDepth:24 07:43:20 INFO - PROCESS | 1899 | Browser inner width/height: 1024/689 07:43:20 INFO - PROCESS | 1899 | __metrics 07:43:20 INFO - PROCESS | 1899 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:43:20 INFO - PROCESS | 1899 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:43:21 INFO - TEST-INFO | 1899: exit 0 07:43:21 INFO - Browser initialized. 07:43:21 INFO - Running cycle 1/1 for kraken test... 07:43:21 INFO - TEST-INFO | started process 1900 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/hlxstmsx7bn09142831q1n6000000w/T/tmpWD1IvF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:43:33 INFO - PROCESS | 1900 | RSS: Main: 231284736 07:43:33 INFO - PROCESS | 1900 | 07:43:36 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49369/tests/kraken/driver.html?testName=audio-beat-detection) 07:43:37 INFO - PROCESS | 1900 | RSS: Main: 283758592 07:43:37 INFO - PROCESS | 1900 | 07:43:39 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49369/tests/kraken/driver.html?testName=audio-dft) 07:43:40 INFO - PROCESS | 1900 | RSS: Main: 285704192 07:43:40 INFO - PROCESS | 1900 | 07:43:43 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49369/tests/kraken/driver.html?testName=audio-fft) 07:43:44 INFO - PROCESS | 1900 | RSS: Main: 377298944 07:43:44 INFO - PROCESS | 1900 | 07:43:46 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49369/tests/kraken/driver.html?testName=audio-oscillator) 07:43:47 INFO - PROCESS | 1900 | RSS: Main: 281956352 07:43:47 INFO - PROCESS | 1900 | 07:43:49 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49369/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:43:49 INFO - PROCESS | 1900 | RSS: Main: 285294592 07:43:49 INFO - PROCESS | 1900 | 07:43:52 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49369/tests/kraken/driver.html?testName=imaging-darkroom) 07:43:53 INFO - PROCESS | 1900 | RSS: Main: 327806976 07:43:53 INFO - PROCESS | 1900 | 07:43:56 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49369/tests/kraken/driver.html?testName=imaging-desaturate) 07:43:56 INFO - PROCESS | 1900 | RSS: Main: 329912320 07:43:56 INFO - PROCESS | 1900 | 07:43:59 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49369/tests/kraken/driver.html?testName=json-parse-financial) 07:44:00 INFO - PROCESS | 1900 | RSS: Main: 327680000 07:44:00 INFO - PROCESS | 1900 | 07:44:01 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49369/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:44:02 INFO - PROCESS | 1900 | RSS: Main: 300572672 07:44:02 INFO - PROCESS | 1900 | 07:44:04 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:44:05 INFO - PROCESS | 1900 | RSS: Main: 305610752 07:44:05 INFO - PROCESS | 1900 | 07:44:07 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:44:07 INFO - PROCESS | 1900 | RSS: Main: 306368512 07:44:07 INFO - PROCESS | 1900 | 07:44:10 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:44:11 INFO - PROCESS | 1900 | RSS: Main: 323149824 07:44:11 INFO - PROCESS | 1900 | 07:44:14 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:44:15 INFO - PROCESS | 1900 | RSS: Main: 317620224 07:44:15 INFO - PROCESS | 1900 | 07:44:16 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49369/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49369/tests/kraken/driver.html?testName=ai-astar) 07:44:17 INFO - PROCESS | 1900 | RSS: Main: 362303488 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | __start_tp_report 07:44:17 INFO - PROCESS | 1900 | _x_x_mozilla_page_load 07:44:17 INFO - PROCESS | 1900 | _x_x_mozilla_page_load_details 07:44:17 INFO - PROCESS | 1900 | |i|pagename|runs| 07:44:17 INFO - PROCESS | 1900 | |0;ai-astar;114;113;114;114;114;115;114;115;113;115 07:44:17 INFO - PROCESS | 1900 | |1;audio-beat-detection;147;112;112;150;112;111;114;112;134;114 07:44:17 INFO - PROCESS | 1900 | |2;audio-dft;190;183;182;187;184;180;183;186;187;185 07:44:17 INFO - PROCESS | 1900 | |3;audio-fft;81;84;85;90;61;63;61;61;80;60 07:44:17 INFO - PROCESS | 1900 | |4;audio-oscillator;91;71;89;68;70;69;85;68;67;85 07:44:17 INFO - PROCESS | 1900 | |5;imaging-gaussian-blur;121;136;89;88;91;89;87;89;89;88 07:44:17 INFO - PROCESS | 1900 | |6;imaging-darkroom;95;96;97;96;96;96;95;95;95;95 07:44:17 INFO - PROCESS | 1900 | |7;imaging-desaturate;85;85;83;86;85;87;85;84;84;86 07:44:17 INFO - PROCESS | 1900 | |8;json-parse-financial;61;59;59;60;59;59;58;59;58;58 07:44:17 INFO - PROCESS | 1900 | |9;json-stringify-tinderbox;73;68;78;72;71;68;71;69;70;72 07:44:17 INFO - PROCESS | 1900 | |10;stanford-crypto-aes;90;89;90;88;88;86;95;103;108;73 07:44:17 INFO - PROCESS | 1900 | |11;stanford-crypto-ccm;143;144;142;143;139;141;142;141;180;162 07:44:17 INFO - PROCESS | 1900 | |12;stanford-crypto-pbkdf2;175;172;175;175;172;172;189;171;174;174 07:44:17 INFO - PROCESS | 1900 | |13;stanford-crypto-sha256-iterative;69;67;67;68;67;69;67;67;67;66 07:44:17 INFO - PROCESS | 1900 | __end_tp_report 07:44:17 INFO - PROCESS | 1900 | __start_cc_report 07:44:17 INFO - PROCESS | 1900 | _x_x_mozilla_cycle_collect,2182 07:44:17 INFO - PROCESS | 1900 | __end_cc_report 07:44:17 INFO - PROCESS | 1900 | __startTimestamp1487778257247__endTimestamp 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | ------- Summary: start ------- 07:44:17 INFO - PROCESS | 1900 | Number of tests: 14 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:0.74 (0.6%) stddev-sans-first:0.78 07:44:17 INFO - PROCESS | 1900 | Values: 114.0 113.0 114.0 114.0 114.0 115.0 114.0 115.0 113.0 115.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#1] audio-beat-detection Cycles:10 Average:121.80 Median:114.00 stddev:15.64 (13.7%) stddev-sans-first:13.67 07:44:17 INFO - PROCESS | 1900 | Values: 147.0 112.0 112.0 150.0 112.0 111.0 114.0 112.0 134.0 114.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#2] audio-dft Cycles:10 Average:184.70 Median:185.50 stddev:2.91 (1.6%) stddev-sans-first:2.37 07:44:17 INFO - PROCESS | 1900 | Values: 190.0 183.0 182.0 187.0 184.0 180.0 183.0 186.0 187.0 185.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#3] audio-fft Cycles:10 Average:72.60 Median:80.50 stddev:12.32 (15.3%) stddev-sans-first:12.69 07:44:17 INFO - PROCESS | 1900 | Values: 81.0 84.0 85.0 90.0 61.0 63.0 61.0 61.0 80.0 60.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:78.00 stddev:9.86 (12.6%) stddev-sans-first:8.90 07:44:17 INFO - PROCESS | 1900 | Values: 91.0 71.0 89.0 68.0 70.0 69.0 85.0 68.0 67.0 85.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#5] imaging-gaussian-blur Cycles:10 Average:96.70 Median:89.00 stddev:17.16 (19.3%) stddev-sans-first:15.79 07:44:17 INFO - PROCESS | 1900 | Values: 121.0 136.0 89.0 88.0 91.0 89.0 87.0 89.0 89.0 88.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#6] imaging-darkroom Cycles:10 Average:95.60 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.71 07:44:17 INFO - PROCESS | 1900 | Values: 95.0 96.0 97.0 96.0 96.0 96.0 95.0 95.0 95.0 95.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.00 stddev:1.15 (1.4%) stddev-sans-first:1.22 07:44:17 INFO - PROCESS | 1900 | Values: 85.0 85.0 83.0 86.0 85.0 87.0 85.0 84.0 84.0 86.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#8] json-parse-financial Cycles:10 Average:59.00 Median:59.00 stddev:0.94 (1.6%) stddev-sans-first:0.67 07:44:17 INFO - PROCESS | 1900 | Values: 61.0 59.0 59.0 60.0 59.0 59.0 58.0 59.0 58.0 58.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#9] json-stringify-tinderbox Cycles:10 Average:71.20 Median:71.50 stddev:2.94 (4.1%) stddev-sans-first:3.04 07:44:17 INFO - PROCESS | 1900 | Values: 73.0 68.0 78.0 72.0 71.0 68.0 71.0 69.0 70.0 72.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#10] stanford-crypto-aes Cycles:10 Average:91.00 Median:88.50 stddev:9.56 (10.8%) stddev-sans-first:10.13 07:44:17 INFO - PROCESS | 1900 | Values: 90.0 89.0 90.0 88.0 88.0 86.0 95.0 103.0 108.0 73.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:143.00 stddev:13.06 (9.1%) stddev-sans-first:13.75 07:44:17 INFO - PROCESS | 1900 | Values: 143.0 144.0 142.0 143.0 139.0 141.0 142.0 141.0 180.0 162.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:174.50 stddev:5.17 (3.0%) stddev-sans-first:5.49 07:44:17 INFO - PROCESS | 1900 | Values: 175.0 172.0 175.0 175.0 172.0 172.0 189.0 171.0 174.0 174.0 07:44:17 INFO - PROCESS | 1900 | 07:44:17 INFO - PROCESS | 1900 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.00 stddev:0.97 (1.4%) stddev-sans-first:0.83 07:44:17 INFO - PROCESS | 1900 | Values: 69.0 67.0 67.0 68.0 67.0 69.0 67.0 67.0 67.0 66.0 07:44:17 INFO - PROCESS | 1900 | -------- Summary: end -------- 07:44:17 INFO - PROCESS | 1900 | 07:44:18 INFO - TEST-INFO | 1900: exit 0 07:44:18 INFO - TEST-OK | kraken | took 60291ms 07:44:18 INFO - SUITE-END | took 1180s 07:44:18 INFO - Completed test suite (00:19:40) 07:44:18 INFO - javascript benchmark 07:44:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7091.449823224849, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3233.6119665640117, 3252.0406480088373, 3261.4455542557776, 3267.460868956622, 3321.352336294422, 5166.914947860944, 5277.815276465324, 5392.164214546741, 5442.1020531612285, 5506.91739623905, 4692.460367057789, 5387.380451248107, 5405.918911216335, 5416.620836541444, 5421.349438067437, 4925.679830810995, 4943.802247910097, 4973.179425394806, 5017.849464516052, 5031.647784655075, 4991.825286114987, 5085.923711144335, 5086.237064440326, 5088.4911508849, 5097.286379906816, 5060.721660308682, 5062.417821950486, 5063.164577844651, 5064.594832413398, 5065.265536497206, 5066.569341605968, 5070.645054846163, 5071.873203169914, 5072.4166720827025, 5074.391073071218, 4297.90403447119, 4875.24433712775, 4991.401031876162, 5010.498950104997, 5024.422191447957, 5291.1534154535475, 5541.168824676291, 5556.555475561986, 5557.305336832896, 5560.4161563036105, 5976.760929562813, 5990.161377407167, 5990.580659353847, 6006.369331220203, 6023.728932198062, 5915.024021036524, 5922.052471604566, 5942.316633587149, 5943.286805583314, 5994.7901823436405, 5575.693336866511, 5579.442055794388, 5588.357338905997, 5610.0, 5626.352969408529, 6190.1952746142715, 6202.44178023971, 6216.347283535254, 6218.005119181, 6219.378062193744, 5638.210650508932, 5688.63023903445, 5690.0895856663565, 5833.679147646835, 5879.647221166743, 5873.853153671193, 5879.853003674857, 5895.616784908967, 5895.911561326584, 5907.7046147692445, 5741.081426971665, 5825.970870145707, 5851.882962340729, 5853.443922827325, 5862.208601838783, 5832.562557808096, 5886.6173698709445, 5886.735096920649, 5893.734781934823, 5898.764049437975, 4673.602743766818, 4703.129920964632, 4711.434627844681, 4715.080559290974, 4722.598579120745, 4176.18564379943, 4243.830246790156, 4256.957430425656, 4269.996550810557, 4296.226679197712, 4599.6090332321455, 5436.184572314184, 5516.531094856902, 5534.252875861707, 5579.218909352694, 4893.7276308160135, 6030.668313242726, 6044.365341639153, 6047.183630209865, 6048.0, 5353.732313384316, 5427.565794736412, 5513.807016754475, 5526.668399896019, 5564.165375193672, 5170.71561064145, 5174.741262936838, 5175.767090480937, 5177.4822517747925, 5192.662476938987, 6137.407629318989, 6144.692765361803, 6153.476954458832, 6154.892119418369, 6167.105769663463, 5864.648121112747, 6043.637381757108, 6085.513158947362, 6113.57204995646, 6135.967692822179, 6241.563090583615, 6246.718897649707, 6247.625142491465, 6258.906116408349, 6269.404406581368, 6008.369121242206, 6009.008513595382, 6014.338422773579, 6014.969925150522, 6067.24159480065, 5775.191473193672, 5820.534357251495, 5838.503727183237, 5921.052631578927, 5933.614315069679, 5799.478046975623, 5816.098504731774, 5821.534277257724, 5826.329972053268, 5855.268091488564, 5784.161296611884, 5805.274340707411, 5807.970960145172, 5814.360420353673, 5815.41845815415, 4404.647628189801, 5419.566434685295, 5511.5039646432015, 5633.0987042073075, 5704.916065947456, 5712.742926568231, 5721.256236689203, 5728.914066289092, 5736.19693242938, 5736.913946290892, 5602.215689803349, 5615.887682246251, 5616.241807355955, 5625.803096891589, 5631.183478395692], "value": 5442.587627366554, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.17728195940856, 432.72089502271035, 451.42443384684503, 475.54347826086956, 530.1808705549925, 38170.42744358837, 40128.79935600322, 40204.39693404601, 40285.59714402855, 40387.79806100973, 40832.0, 41199.026141209506, 41502.0, 41523.377149342785, 41715.0, 7461.179270280292, 9203.401778884385, 9592.520373981308, 9600.0, 9601.47191904445, 7482.812929676747, 7622.923770762304, 7633.6564854581675, 7634.083909930816, 7636.052806534326, 11303.039241664428, 11637.0, 11647.475863586116, 11750.706232344175, 11754.353510556915, 11700.765984680302, 11750.471228794724, 11755.17713760037, 11758.588449404315, 11764.0, 11278.097752179807, 11347.943260283646, 11365.318080915089, 11385.487653055632, 11404.828927566094, 27839.721602783917, 28464.591727571697, 28506.429871402663, 28942.0, 29023.564646530318, 3102.4570700127388, 3767.585565587783, 3829.0618798394294, 3895.61043895611, 3996.86010989614, 23802.523949521084, 25667.0, 29947.550786738215, 30101.548476772867, 30203.848980755174, 2902.680705122435, 3170.8414579270943, 3195.121341631047, 3225.7580681448985, 3232.951505727416, 403882.0, 405024.0, 406381.0, 406485.0, 411415.9429202865, 57453.42546574481, 57599.0, 57796.71101644465, 57928.71035644879, 57994.04071511361, 60379.0, 60754.2660580275, 60877.69561152166, 60956.39043609507, 61001.764761757484, 14933.328000240015, 15151.848481515044, 15204.695906082037, 15217.467388641344, 15239.314230859638, 11723.944844963995, 11767.293962362286, 11782.410879455992, 11785.175037747447, 11790.469428875722, 12675.683107922192, 13090.214587124803, 15732.213389330487, 15777.921110394374, 15959.840401596068, 5180.533751962342, 6776.796696099125, 6870.519063665595, 6961.642479716406, 6984.580925144406, 637.4740838808002, 739.8557281330196, 837.681680961243, 845.6828689241535, 846.221476241859, 23125.95933183011, 26811.865940670174, 28387.0, 29036.983705570205, 29472.0, 900.5317235037875, 1009.6617633092997, 1020.7244044108049, 1021.8109649714827, 1050.417018554694, 14141.0, 14231.715365692835, 14519.274036298142, 14614.561563153122, 15037.473688420852, 549346.0, 552304.2384788131, 552836.0, 553553.4644653583, 554173.0, 55704.442955569924, 55706.0, 55759.442405576236, 55792.442075579536, 55889.895965084834, 1335.9866401335862, 1387.47276035106, 1391.7842734376188, 1395.5534229046812, 1398.349767358163, 25491.745082548936, 27676.72323276822, 28075.0, 28088.06767052655, 28658.57012144861, 47192.29211561898, 47828.76085619689, 47834.76082619565, 47883.80290492765, 47935.28097078617, 470538.0, 472162.0, 472437.0, 473133.6343318261, 473400.0, 36580.90257292285, 37459.43810842785, 37673.81163094167, 37764.62235377611, 37769.433458497595, 43554.34668479912, 44423.777881110385, 44507.332390014824, 45019.54980450284, 45070.0, 29614.815407383463, 32528.674713252563, 33254.33491330208, 35903.28193436169, 37476.06309842276, 35340.823295883354, 35536.0, 35636.287274254886, 37153.0, 37264.44103338398, 34276.0, 34537.827310863286, 34537.82731086429, 36236.4564531527, 36502.26995460129, 30748.923787667325, 31646.208844779063, 32326.676733233307, 32400.027999160062, 32408.83795581007, 22608.660870086635, 23588.52822943566, 24086.75913240915, 24439.0, 24549.263522094367], "value": 18866.39213309395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.4113912678924, 355.8612141264909, 387.1772483472621, 394.84995701633386, 417.8433087592153, 13768.724625507484, 14036.368363423644, 14659.706805863889, 20760.169593216255, 21565.029573669184, 20932.37202883912, 21810.127594896185, 22391.888040559814, 22589.54820903581, 22600.88699556504, 5874.5594080443925, 5924.763009479616, 6087.05650624154, 6204.472619827297, 6206.565540412173, 3874.651281384675, 6047.7278522466595, 6167.938320616804, 6168.84577885552, 6169.598976066563, 4036.777977211252, 4067.755934643916, 4102.261592913274, 4107.876763697094, 4113.465249517573, 6637.369449902251, 6729.5625784323865, 6732.518845853904, 6734.595924244561, 6742.0, 4627.259638457831, 5646.774129034875, 5854.47309742121, 5930.495907847838, 5957.821265362046, 20865.165393384246, 26645.06742264031, 26765.0, 26923.865380673167, 27301.726982730117, 3073.339232065094, 3113.641931177898, 3148.590683211191, 3179.0462861141564, 3256.0069178900426, 15264.923675381662, 15922.363105475768, 16037.278322475517, 16046.75929861053, 16069.678606427922, 1805.7201133824278, 1823.216017112641, 1845.6157881588808, 1861.2909339371413, 1921.6637088509456, 118866.0, 122465.0, 125910.0, 126416.0, 127637.99999999907, 10501.264911456125, 10504.527296271686, 11316.377599231957, 11513.0, 12025.879741202476, 14901.701965960838, 14926.776098358534, 14933.40266389354, 14937.850621493862, 14958.70082598342, 8143.552104634184, 8414.284785793276, 8440.412824549665, 8612.913870861337, 8622.568871556397, 7142.21435642079, 8178.263956243966, 8220.671173153127, 8374.246317831425, 8383.0, 6731.764388246388, 7294.088238970129, 7294.8905766413545, 7296.598687072262, 7303.196648368676, 1918.539550507896, 1955.4720225539024, 1956.8825870447818, 1958.1286327584373, 1959.5395082155683, 1022.7187523431116, 1029.7219750667277, 1043.7912417516527, 1061.808874402615, 1115.8884111588777, 22474.88762556177, 22685.659715104288, 22890.771092289197, 22942.082316707143, 23022.539549209258, 1054.3779170289565, 1063.1707268330715, 1080.7622323088908, 1081.3986487495656, 1094.1684319916922, 11716.765664686658, 11728.061755059574, 11820.113491488173, 12063.573747129953, 12110.333931633668, 668340.0, 676392.0, 676591.0, 689643.0, 696373.0, 84448.0, 121516.39241803734, 123899.14151287738, 125390.0, 129036.0, 1033.3593172233113, 1036.2176556699644, 1072.222638587018, 1078.6386560502162, 1079.5465904320204, 16896.746548802024, 19538.706919395936, 19949.60100797947, 19992.90003549973, 20030.799692002893, 46414.30378544392, 51283.74358128185, 52761.0, 53540.46459535511, 54082.45917540774, 66223.0, 75584.0, 78266.82599760895, 79198.0, 79223.0, 7366.7053317866685, 7722.961385193038, 7936.365090792608, 7992.240737129963, 8506.61720222579, 12742.08868669707, 13308.001899857743, 13319.600411987656, 13804.654883627989, 13809.51666691661, 11372.54509819598, 11380.54477820878, 11611.593594224161, 11777.587784427504, 11794.0, 11319.434028298718, 11354.318740875575, 11519.0, 11665.300081995107, 11752.059835213333, 11652.708682283012, 11849.111316651459, 12005.75988480243, 12037.638870833889, 12060.276383416673, 7507.099148102263, 7547.396208303432, 7793.844123117619, 8014.559199244098, 8080.63637136342, 11255.549778008788, 11324.207305488537, 11661.300321980709, 11687.0, 11712.238704484182], "value": 10011.73349119231, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.9592912212634, 1410.1609542322321, 1432.126402894235, 1446.1756798624774, 1459.5621313605918, 8124.959375203123, 8533.743987680371, 8549.61526731297, 8562.015368232655, 8589.527575983318, 8110.432269741121, 8450.323974082074, 8464.0, 8545.27365173961, 8550.230479256865, 2271.23913488981, 2310.4685922237895, 2313.641385585237, 2316.3861576682193, 2317.9536409271805, 1845.6862333403287, 2270.3529494094187, 2321.5589038082794, 2332.346942856003, 2335.2760644200353, 1987.8707883987568, 2019.515316324079, 2019.6970454431805, 2020.8282296004857, 2021.757389113301, 1638.5985433568792, 2182.9563408731815, 2261.3894248552965, 2265.8980345884474, 2268.7164104486938, 1908.2271679969635, 1923.7691477022847, 2295.070496448941, 2303.2859813457712, 2313.5835549601065, 7348.559086454777, 8435.072142064368, 8515.105913879015, 8519.53142577158, 8523.488590684517, 4572.634189264884, 4764.499727528629, 4766.451858036336, 4770.833020844254, 4773.093112308685, 3388.576797744928, 3408.0164030695955, 3518.4194607889667, 3519.5776506819348, 3583.910402239939, 1194.331174542259, 1208.172401904698, 1237.412229191136, 1247.5321754342121, 1254.0406588959454, 10686.305390149615, 10725.946370268099, 10810.513526891387, 10821.188410869216, 10823.783524329549, 4205.957940420618, 4301.118270754488, 4430.224710675619, 4446.487734430101, 4481.1933851906315, 7767.961160194276, 8359.958200209081, 8750.212480876751, 8762.299016078698, 8766.780830479289, 5123.0, 5123.436421993578, 5128.769205385766, 5129.179331306973, 5131.589472842164, 4645.837395691202, 4684.929726054112, 4742.715437073786, 4810.759462026885, 4868.9269660955115, 3498.2828520153307, 3536.3104194682305, 3563.1626567757075, 3605.6214097519905, 3624.5469316335457, 1127.8308253762002, 1130.2483848240827, 1135.6933627920416, 1145.73075327298, 1147.0651419093579, 827.1563005734117, 854.4702284583474, 857.9914200857911, 902.7833320003152, 913.1735779119907, 5372.274742909735, 5541.556675465953, 5586.273784408001, 5780.479756821906, 5812.686768541975, 952.8237276103804, 953.3660116022905, 968.0029569543382, 993.7217579077869, 1021.4126877045728, 3560.181158333546, 3591.6049234584175, 3699.2416554606243, 3764.284785890672, 3811.7712937223855, 9779.070988256246, 10077.09306162449, 10080.697579072494, 10099.848502272473, 10103.242256830767, 9468.100530449734, 9890.60437582503, 9915.900840991642, 9924.206063514901, 10055.145312648361, 7552.433567482351, 7807.258310460497, 7819.732277639535, 7822.335101516321, 7826.608669566613, 4938.2839488273285, 5473.945260547343, 5486.341639003185, 5784.623999440023, 5798.304203495608, 7485.7754267372065, 9233.907660923305, 9235.861462077939, 9303.0, 9318.48748318849, 7635.885461717968, 9219.216366608645, 9386.436813791195, 9410.764730881509, 9455.05449455049, 6706.765263215764, 7032.367086962198, 7125.18060423058, 7271.163816160997, 7278.490505664553, 7743.380529557735, 7897.565633890191, 7911.367090632621, 7918.643661035382, 7919.604019798871, 6876.312368763083, 7034.613096279753, 7051.964740176266, 7129.750458733919, 7134.215236324104, 6925.20360158568, 6936.237013928565, 6953.582785032914, 7019.122609673791, 7057.988473285089, 6101.786437474667, 6242.344553821965, 6289.465395441439, 6329.556931014785, 6336.936630633634, 4186.413902053776, 4810.5670489656095, 4832.0, 4925.950740492549, 5005.899882002413, 4085.4280400744515, 4865.854024379274, 4943.2585112233455, 4993.15116430215, 5055.51972562606], "value": 4317.580068662159, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.9466865969108, 355.0, 365.2694610778443, 367.3479573756583, 369.11596725841594, 4605.5624715652, 5191.299174611427, 5232.4505926877655, 5242.7640756165965, 5282.841514754554, 4056.918861622773, 4905.803767849291, 5158.375111839768, 5197.740112994354, 5211.973940130294, 3523.9823800881086, 3977.2840888640035, 3990.381490868913, 4007.7194596378267, 4015.176888737816, 3315.1214928044087, 4029.629925825219, 4044.8786536403954, 4048.7773172475504, 4052.898677533056, 3662.780233186004, 3912.9630647878193, 3994.3609022556398, 4045.858394956177, 4052.837886484537, 3901.581019767734, 3929.7445666031617, 3931.0, 3942.1918506706056, 3955.3671412573995, 2921.5033444314518, 3413.5050417689545, 3421.9315613687586, 3464.532288141094, 3484.5818501779695, 4390.05613793036, 4914.827981020647, 5083.822066227664, 5092.955944031464, 5105.463926287724, 3594.658507441815, 4450.421445212101, 4524.502304746476, 4537.455505339348, 4555.838261243362, 5249.895002099936, 5472.206530053159, 5503.3120859892515, 5519.558435325164, 5536.750846211889, 3782.8108594570162, 3788.5643151037707, 3794.2411517696573, 3809.1810260794064, 3833.5591406988274, 5479.3972862890205, 5679.176519404663, 5731.512821410143, 5742.019003443847, 5759.452851979056, 3829.215010922754, 3836.5396152461326, 3841.961580384216, 3848.978551836795, 3854.6338097881217, 3310.93378132436, 3934.0, 3935.5474120475938, 3948.2103579284258, 3963.1677347756718, 3440.7935523868646, 4291.485021797404, 4505.008898042425, 4510.66170037242, 4570.977145114253, 5546.77812887488, 5548.389677135512, 5552.888942221133, 5558.138488534284, 5560.944390556043, 1157.8031734605138, 1189.9821502677466, 1242.5402601037492, 1255.1966741285585, 1264.0709078827056, 713.8286811165283, 846.7425872579215, 852.3394369363792, 864.6843901975859, 873.7946582553095, 4210.789460526961, 4346.2842815544855, 4406.9559304407185, 4620.584147426748, 4663.160631086437, 5398.784048638089, 5451.781928722886, 5461.579989202836, 5474.315710536183, 5576.498115169654, 4094.4677191965447, 4715.108346017676, 4874.19654727753, 4897.461279259279, 4903.828366007173, 2450.4363996280954, 2497.875106244717, 2732.4808286425514, 2841.5311473606625, 2887.826730396183, 4862.465128835825, 5249.790008399697, 5475.534579560782, 5583.553315734732, 5688.63023903445, 5230.895382092337, 5501.669899806025, 5523.4200408956485, 5552.7223638817895, 5576.637518561281, 4924.556789888856, 5026.447090820006, 5300.257963884982, 5533.446655334435, 5545.362283337387, 4315.331123675835, 4894.115765430406, 5363.839084827461, 5421.268128802719, 5427.402985671652, 4628.930566041579, 4639.930401043919, 4944.53026962438, 5308.575313974796, 5342.6260161788305, 4654.069186162713, 5009.323741295024, 5067.719526213293, 5573.804916827891, 5652.095664693629, 3178.3154927888254, 3309.9007029789145, 3625.2749450109554, 3667.7982710951155, 3677.44838274261, 4909.312696222603, 4924.704517728947, 4990.4011518618, 5042.369703787027, 5468.316460442445, 5145.0, 5220.817271395483, 5223.817166399158, 5227.89544209106, 5275.916013174698, 4650.34895114691, 4910.950890491193, 4925.128451188669, 5210.426853046238, 5220.791168353223, 4506.439912469113, 4649.3955785748985, 5110.565601923878, 5135.794568217229, 5169.216620266002, 4546.727196368229, 4936.358273424576, 5218.921716174336, 5251.684898906078, 5327.493888080626, 4499.212637788309, 5093.745312734422, 5106.6338280769405, 5117.385913690232, 5163.586913047023], "value": 3915.5848090379905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [743.3124359967029, 765.9731909383173, 772.1236396689756, 788.3850596534702, 803.6263137640996, 14323.64190895228, 15241.314140863687, 15247.237638118106, 15291.235438228072, 15357.385704571818, 13794.448222071105, 13911.860881391183, 13917.0, 13924.373403196854, 13954.092983956036, 881.5548148185158, 891.5408564589242, 907.2605826251583, 911.1935936696038, 918.609590923858, 906.6917248135633, 927.5872236854602, 928.512530921265, 928.7770934975591, 928.8281667891462, 949.3781573069616, 951.6859436386011, 951.7953639967405, 954.4750387286999, 957.6887511558771, 946.3186505715873, 946.8627049077915, 947.2232769129316, 947.3415975896754, 948.1987720376305, 704.8167476456107, 704.89426586012, 704.9189343225493, 705.7882635209417, 706.9081019467487, 15002.24988750569, 15262.847371526253, 15475.994060386152, 15504.379824806994, 15507.379704811794, 13589.796153057712, 13764.449422023106, 13772.173669579857, 13961.930190349085, 13967.930160349235, 10862.511186996604, 11309.886901130965, 11430.542778288858, 11660.475278612483, 12116.09129315305, 4354.738715677069, 4386.342048692722, 4417.076439435819, 4418.668599855024, 4584.7478388688605, 78342.21657783464, 81792.59103704443, 82842.17157828405, 105329.47335263352, 106398.93601063968, 10572.52423640938, 10825.783484330426, 10842.186835987333, 11119.533498808518, 11267.323960562393, 21807.0, 21967.23114690978, 22027.33917982463, 22128.0, 22149.114035438724, 7371.852562948711, 7678.424118191158, 7731.613419329011, 7800.765977020698, 7975.202479751978, 4190.308599081118, 4209.221294060609, 4242.0294107408035, 4342.9782851086175, 4368.5194628590825, 3305.190228394011, 3510.5606701252364, 3621.80080095592, 3729.272791805626, 3731.869384571527, 675.6689222281046, 695.8434352270699, 696.6690821859678, 698.7205117952859, 705.3475535129984, 493.60758197233287, 623.099621047591, 625.7215539085155, 627.2222444169197, 699.4020112803581, 9323.860142097874, 9768.462734549526, 9958.253131015057, 9979.0, 10063.062658218274, 374.4383424862706, 456.24263722220957, 505.8861756104847, 591.9256549362979, 687.4294335701455, 3731.4402839573736, 4866.270059491034, 4936.3829521309835, 5004.992012779524, 5206.873589950017, 84037.0, 99275.01449971105, 100607.99392006133, 101447.49276253571, 105598.0, 46937.765311173906, 61299.69350153221, 74354.62822685852, 75212.62393687997, 90444.0, 59985.0, 71622.49321273835, 73397.0, 73614.0, 73763.63118184482, 9954.55204515784, 10293.639722609973, 10299.639512617023, 10421.895781042396, 10442.843357349799, 47715.284270735276, 47976.52023479721, 48382.516174839206, 49437.25844112269, 50362.46012938647, 52670.68323291948, 60986.0, 61092.778144437754, 63825.08524744265, 65649.35876603123, 12132.454039568063, 12152.515872500402, 12171.573994910135, 12314.322712250912, 12411.31737754396, 13539.59381218565, 13718.24549649739, 13738.65653358674, 13803.861961380258, 14480.420783168976, 12532.0, 12653.493860245855, 12817.551385701456, 12856.55002074923, 13134.146280491737, 12624.74750505003, 12789.93605031969, 12946.0, 13201.60395188146, 13294.734105318033, 12097.274163550215, 12535.310557919402, 12543.811842822182, 12961.675958101123, 13205.943524517823, 10340.948295258475, 10629.468526573795, 10699.732506687084, 10748.355098694103, 11209.887901120885, 6985.5808651481075, 8506.319494440553, 10160.542775575264, 10193.184545236512, 10196.490175491344], "value": 7316.780356511571, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 115.0, 114.0, 115.0, 113.0, 115.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 112.0, 112.0, 150.0, 112.0, 111.0, 114.0, 112.0, 134.0, 114.0], "value": 121.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 183.0, 182.0, 187.0, 184.0, 180.0, 183.0, 186.0, 187.0, 185.0], "value": 184.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 85.0, 90.0, 61.0, 63.0, 61.0, 61.0, 80.0, 60.0], "value": 72.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 89.0, 68.0, 70.0, 69.0, 85.0, 68.0, 67.0, 85.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 136.0, 89.0, 88.0, 91.0, 89.0, 87.0, 89.0, 89.0, 88.0], "value": 96.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "value": 95.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 83.0, 86.0, 85.0, 87.0, 85.0, 84.0, 84.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 59.0, 59.0, 60.0, 59.0, 59.0, 58.0, 59.0, 58.0, 58.0], "value": 59.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 78.0, 72.0, 71.0, 68.0, 71.0, 69.0, 70.0, 72.0], "value": 71.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 88.0, 88.0, 86.0, 95.0, 103.0, 108.0, 73.0], "value": 91.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 144.0, 142.0, 143.0, 139.0, 141.0, 142.0, 141.0, 180.0, 162.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 172.0, 175.0, 175.0, 172.0, 172.0, 189.0, 171.0, 174.0, 174.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 67.0, 68.0, 67.0, 69.0, 67.0, 67.0, 67.0, 66.0], "value": 67.4, "unit": "score"}]}]} 07:44:18 INFO - Return code: 0 07:44:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:44:18 ERROR - # TBPL SUCCESS # 07:44:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:44:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:44:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:44:18 INFO - 2017-02-22 07:44:18.570 screenresolution[1904:11283] starting screenresolution argv=screenresolution get 07:44:18 INFO - 2017-02-22 07:44:18.573 screenresolution[1904:11283] Display 0: 1600x1200x32@60 07:44:18 INFO - 2017-02-22 07:44:18.579 screenresolution[1905:11286] starting screenresolution argv=screenresolution list 07:44:18 INFO - Available Modes on Display 0 07:44:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:44:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:44:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:44:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:44:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:44:18 INFO - Intel Iris: 07:44:18 INFO - Chipset Model: Intel Iris 07:44:18 INFO - Type: GPU 07:44:18 INFO - Bus: Built-In 07:44:18 INFO - VRAM (Dynamic, Max): 1536 MB 07:44:18 INFO - Vendor: Intel (0x8086) 07:44:18 INFO - Device ID: 0x0a2e 07:44:18 INFO - Revision ID: 0x0009 07:44:18 INFO - Displays: 07:44:18 INFO - Display: 07:44:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:44:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:44:18 INFO - Display Serial Number: 1600x1200 60 07:44:18 INFO - Main Display: Yes 07:44:18 INFO - Mirror: Off 07:44:18 INFO - Online: Yes 07:44:18 INFO - Rotation: Supported 07:44:18 INFO - Return code: 0 07:44:18 INFO - Running post-action listener: _resource_record_post_action 07:44:18 INFO - [mozharness: 2017-02-22 15:44:18.826653Z] Finished run-tests step (success) 07:44:18 INFO - Running post-run listener: _resource_record_post_run 07:44:18 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 1896448; Write bytes: 509924352; Read time: 16; Write time: 1566 07:44:18 INFO - TinderboxPrint: CPU usage
53.9% 07:44:18 INFO - TinderboxPrint: I/O read bytes / time
1,896,448 / 16 07:44:18 INFO - TinderboxPrint: I/O write bytes / time
509,924,352 / 1,566 07:44:18 INFO - TinderboxPrint: CPU idle
2,215.7 (46.1%) 07:44:18 INFO - TinderboxPrint: CPU system
963.4 (20.0%) 07:44:18 INFO - TinderboxPrint: CPU user
1,630.6 (33.9%) 07:44:18 INFO - TinderboxPrint: Swap in / out
212,729,856 / 0 07:44:18 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203794944; Write bytes: 201576448; Read time: 15638; Write time: 414 07:44:18 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 1028096; Write bytes: 297718784; Read time: 13; Write time: 1115 07:44:19 INFO - Running post-run listener: _upload_blobber_files 07:44:19 INFO - Blob upload gear active. 07:44:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:44:19 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 07:44:19 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'] 07:44:19 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 07:44:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:44:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:44:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:44:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:20 INFO - (blobuploader) - INFO - Done attempting. 07:44:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:44:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:44:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:21 INFO - (blobuploader) - INFO - Done attempting. 07:44:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:44:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:44:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:22 INFO - (blobuploader) - INFO - Done attempting. 07:44:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:44:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:44:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:44:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:44:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:44:25 INFO - (blobuploader) - INFO - Done attempting. 07:44:25 INFO - (blobuploader) - INFO - Iteration through files over. 07:44:25 INFO - Return code: 0 07:44:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:44:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:44:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8384c3b9e493f8d218454f46c0d4342ceea7f50f9ca7e7b9c9ca3cf3ce331a6a295849ab253c5818974ec7c44ae58518106d1fd30fb0f505290ea6e5b89a3082", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1fe698c47904ba06b8041388a36652196d5ad3e323d23a91d1d0d04bf1ce3f1c97fd04bb1b1fee1a932a86b8a04721cbbf9fc34ef59dc4c6e444d257ebb3f25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c42b1ff35296356c4eb653024fcd57cce983b3fe7c98c6fa81d688bfed6d7e38c6892f3c9ea52124d52b3ad61e7341e153bf89a1195941dd0723683fe00514", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba955f1942a631d4396e1e15baad8a81214d0ddb0337f1092f919920912c0a65e5786dbf71b0d6338d40a153861840f9d5dea6682e45957082270c33604a4ae5"} 07:44:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:44:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:44:25 INFO - Contents: 07:44:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8384c3b9e493f8d218454f46c0d4342ceea7f50f9ca7e7b9c9ca3cf3ce331a6a295849ab253c5818974ec7c44ae58518106d1fd30fb0f505290ea6e5b89a3082", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1fe698c47904ba06b8041388a36652196d5ad3e323d23a91d1d0d04bf1ce3f1c97fd04bb1b1fee1a932a86b8a04721cbbf9fc34ef59dc4c6e444d257ebb3f25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c42b1ff35296356c4eb653024fcd57cce983b3fe7c98c6fa81d688bfed6d7e38c6892f3c9ea52124d52b3ad61e7341e153bf89a1195941dd0723683fe00514", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba955f1942a631d4396e1e15baad8a81214d0ddb0337f1092f919920912c0a65e5786dbf71b0d6338d40a153861840f9d5dea6682e45957082270c33604a4ae5"} 07:44:25 INFO - Running post-run listener: copy_logs_to_upload_dir 07:44:25 INFO - Copying logs to upload dir... 07:44:25 INFO - mkdir: /builds/slave/test/build/upload/logs 07:44:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.688501 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-02-22 07:44:26.051015) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 07:44:26.055269) ========= 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.nSfO2OFeSX/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.utpNaEZBVq/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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/8384c3b9e493f8d218454f46c0d4342ceea7f50f9ca7e7b9c9ca3cf3ce331a6a295849ab253c5818974ec7c44ae58518106d1fd30fb0f505290ea6e5b89a3082", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1fe698c47904ba06b8041388a36652196d5ad3e323d23a91d1d0d04bf1ce3f1c97fd04bb1b1fee1a932a86b8a04721cbbf9fc34ef59dc4c6e444d257ebb3f25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c42b1ff35296356c4eb653024fcd57cce983b3fe7c98c6fa81d688bfed6d7e38c6892f3c9ea52124d52b3ad61e7341e153bf89a1195941dd0723683fe00514", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba955f1942a631d4396e1e15baad8a81214d0ddb0337f1092f919920912c0a65e5786dbf71b0d6338d40a153861840f9d5dea6682e45957082270c33604a4ae5"} build_url:https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011184 build_url: 'https://queue.taskcluster.net/v1/task/JBABCYADQgGrVnDM6jfwgA/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/8384c3b9e493f8d218454f46c0d4342ceea7f50f9ca7e7b9c9ca3cf3ce331a6a295849ab253c5818974ec7c44ae58518106d1fd30fb0f505290ea6e5b89a3082", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a1fe698c47904ba06b8041388a36652196d5ad3e323d23a91d1d0d04bf1ce3f1c97fd04bb1b1fee1a932a86b8a04721cbbf9fc34ef59dc4c6e444d257ebb3f25", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b1c42b1ff35296356c4eb653024fcd57cce983b3fe7c98c6fa81d688bfed6d7e38c6892f3c9ea52124d52b3ad61e7341e153bf89a1195941dd0723683fe00514", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba955f1942a631d4396e1e15baad8a81214d0ddb0337f1092f919920912c0a65e5786dbf71b0d6338d40a153861840f9d5dea6682e45957082270c33604a4ae5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-22 07:44:26.091287) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 07:44:26.091648) ========= 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.nSfO2OFeSX/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.utpNaEZBVq/Listeners TMPDIR=/var/folders/sv/hlxstmsx7bn09142831q1n6000000w/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.005230 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-22 07:44:26.140514) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 07:44:26.140860) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-22 07:44:26.141187) ========= ========= Total master_lag: 0.20 =========