builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0244 starttime: 1489067523.56 results: success (0) buildid: 20170309030216 builduid: 53ddcc78c897471691e249a9c58da4d6 revision: c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:03.556073) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:03.556503) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:03.556780) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:03.582792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:03.583054) ========= 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.xs98sMBB3m/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.4aODVN5QI8/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-09 05:52:03-- 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% 157M=0s 2017-03-09 05:52:03 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.105031 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:03.711844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:03.712176) ========= 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.xs98sMBB3m/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.4aODVN5QI8/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.025913 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:03.761244) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:03.761756) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 --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 c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xs98sMBB3m/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.4aODVN5QI8/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-09 05:52:04,008 truncating revision to first 12 chars 2017-03-09 05:52:04,008 Setting DEBUG logging. 2017-03-09 05:52:04,008 attempt 1/10 2017-03-09 05:52:04,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c40ca7a1bdd9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-09 05:52:04,608 unpacking tar archive at: mozilla-central-c40ca7a1bdd9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.875034 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:04.659843) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:04.660172) ========= script_repo_revision: c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:04.660560) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:04.660827) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-09 05:52:04.680285) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-09 05:52:04.680558) ========= /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.xs98sMBB3m/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.4aODVN5QI8/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:52:05 INFO - MultiFileLogger online at 20170309 05:52:05 in /builds/slave/test 05:52:05 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 05:52:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:05 INFO - {'append_to_log': False, 05:52:05 INFO - 'base_work_dir': '/builds/slave/test', 05:52:05 INFO - 'blob_upload_branch': 'Firefox', 05:52:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:05 INFO - 'branch': 'Firefox', 05:52:05 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:05 INFO - 'config_files': ('talos/mac_config.py',), 05:52:05 INFO - 'default_actions': ('clobber', 05:52:05 INFO - 'read-buildbot-config', 05:52:05 INFO - 'download-and-extract', 05:52:05 INFO - 'populate-webroot', 05:52:05 INFO - 'create-virtualenv', 05:52:05 INFO - 'install', 05:52:05 INFO - 'run-tests'), 05:52:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:05 INFO - 'download_minidump_stackwalk': True, 05:52:05 INFO - 'download_symbols': 'ondemand', 05:52:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:05 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:05 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:05 INFO - 'gecko_profile': False, 05:52:05 INFO - 'gecko_profile_interval': 0, 05:52:05 INFO - 'installer_path': 'installer.exe', 05:52:05 INFO - 'log_level': 'info', 05:52:05 INFO - 'log_name': 'talos', 05:52:05 INFO - 'log_to_console': True, 05:52:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:52:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:52:05 INFO - 'opt_config_files': (), 05:52:05 INFO - 'pip_index': False, 05:52:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:05 INFO - 'cmd': ('bash', 05:52:05 INFO - '-c', 05:52:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:05 INFO - 'enabled': True, 05:52:05 INFO - 'halt_on_failure': False, 05:52:05 INFO - 'name': 'check_screen_resolution'},), 05:52:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:05 INFO - 'cmd': ('bash', 05:52:05 INFO - '-c', 05:52:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:05 INFO - 'enabled': True, 05:52:05 INFO - 'halt_on_failure': False, 05:52:05 INFO - 'name': 'check_screen_resolution'},), 05:52:05 INFO - 'run_cmd_checks_enabled': True, 05:52:05 INFO - 'suite': 'dromaeojs', 05:52:05 INFO - 'system_bits': '32', 05:52:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:05 INFO - 'title': 't-yosemite-r7-0244', 05:52:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:05 INFO - 'use_talos_json': True, 05:52:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:05 INFO - 'work_dir': 'build'} 05:52:05 INFO - [mozharness: 2017-03-09 13:52:05.033175Z] Running clobber step. 05:52:05 INFO - Running pre-action listener: _resource_record_pre_action 05:52:05 INFO - Running main action method: clobber 05:52:05 INFO - rmtree: /builds/slave/test/build 05:52:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:07 INFO - Running post-action listener: _resource_record_post_action 05:52:07 INFO - [mozharness: 2017-03-09 13:52:07.517278Z] Finished clobber step (success) 05:52:07 INFO - [mozharness: 2017-03-09 13:52:07.517549Z] Running read-buildbot-config step. 05:52:07 INFO - Running pre-action listener: _resource_record_pre_action 05:52:07 INFO - Running main action method: read_buildbot_config 05:52:07 INFO - Using buildbot properties: 05:52:07 INFO - { 05:52:07 INFO - "project": "", 05:52:07 INFO - "product": "firefox", 05:52:07 INFO - "script_repo_revision": "production", 05:52:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:52:07 INFO - "repository": "", 05:52:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:52:07 INFO - "buildid": "20170309030216", 05:52:07 INFO - "stage_platform": "macosx64", 05:52:07 INFO - "basedir": "/builds/slave/test", 05:52:07 INFO - "nightly_build": "True", 05:52:07 INFO - "buildnumber": 4, 05:52:07 INFO - "slavename": "t-yosemite-r7-0244", 05:52:07 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:52:07 INFO - "platform": "yosemite_r7", 05:52:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:52:07 INFO - "branch": "mozilla-central", 05:52:07 INFO - "repo_path": "mozilla-central", 05:52:07 INFO - "revision": "c40ca7a1bdd93632c6bdc5e23bd33d984d508b19", 05:52:07 INFO - "pgo_build": "False", 05:52:07 INFO - "builduid": "53ddcc78c897471691e249a9c58da4d6", 05:52:07 INFO - "slavebuilddir": "test" 05:52:07 INFO - } 05:52:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:52:07 INFO - Running post-action listener: _resource_record_post_action 05:52:07 INFO - [mozharness: 2017-03-09 13:52:07.523490Z] Finished read-buildbot-config step (success) 05:52:07 INFO - [mozharness: 2017-03-09 13:52:07.523713Z] Running download-and-extract step. 05:52:07 INFO - Running pre-action listener: _resource_record_pre_action 05:52:07 INFO - Running main action method: download_and_extract 05:52:07 INFO - mkdir: /builds/slave/test/build/tests 05:52:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:07 INFO - trying https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:52:07 INFO - Downloading https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:52:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:52:08 INFO - Downloaded 1199 bytes. 05:52:08 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:52:08 INFO - Using the following test package requirements: 05:52:08 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:52:08 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:08 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:52:08 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:08 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:52:08 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:08 INFO - u'jsshell-mac.zip'], 05:52:08 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:08 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:52:08 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:52:08 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:08 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:52:08 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:08 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:52:08 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:08 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:52:08 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:52:08 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:52:08 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:52:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:52:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:52:08 INFO - Fetch https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:52:10 INFO - Expected file size: 51789109 05:52:10 INFO - Obtained file size: 51789109 05:52:26 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:52:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:52:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:52:26 INFO - Fetch https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:52:28 INFO - Expected file size: 51789109 05:52:28 INFO - Obtained file size: 51789109 05:52:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:52:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:52:43 INFO - Fetch https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:52:44 INFO - Expected file size: 14404424 05:52:44 INFO - Obtained file size: 14404424 05:52:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:44 INFO - trying https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:52:44 INFO - Downloading https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:52:47 INFO - Downloaded 75013985 bytes. 05:52:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:52:47 INFO - mkdir: /builds/slave/test/properties 05:52:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:52:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:52:47 INFO - Contents: 05:52:47 INFO - build_url:https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:52:47 INFO - Running post-action listener: _resource_record_post_action 05:52:47 INFO - Running post-action listener: set_extra_try_arguments 05:52:47 INFO - [mozharness: 2017-03-09 13:52:47.730637Z] Finished download-and-extract step (success) 05:52:47 INFO - [mozharness: 2017-03-09 13:52:47.730757Z] Running populate-webroot step. 05:52:47 INFO - Running pre-action listener: _resource_record_pre_action 05:52:47 INFO - Running main action method: populate_webroot 05:52:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:52:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:52:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:52:47 INFO - '--tppagecycles', 05:52:47 INFO - '7'], 05:52:47 INFO - 'tests': ['tsvgm']}}, 05:52:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:52:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:52:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:52:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:52:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:52:47 INFO - 'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:52:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:52:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:52:47 INFO - 'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['damp', 'tps']}, 05:52:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:52:47 INFO - 'tests': ['damp', 'tps']}, 05:52:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['dromaeo_dom']}, 05:52:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:52:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['basic_compositor_video']}, 05:52:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:52:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['a11yr', 05:52:47 INFO - 'ts_paint', 05:52:47 INFO - 'tpaint', 05:52:47 INFO - 'sessionrestore', 05:52:47 INFO - 'sessionrestore_no_auto_restore', 05:52:47 INFO - 'tabpaint']}, 05:52:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:52:47 INFO - 'ts_paint', 05:52:47 INFO - 'tpaint', 05:52:47 INFO - 'sessionrestore', 05:52:47 INFO - 'sessionrestore_no_auto_restore', 05:52:47 INFO - 'tabpaint']}, 05:52:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:52:47 INFO - 'ts_paint', 05:52:47 INFO - 'tpaint', 05:52:47 INFO - 'sessionrestore', 05:52:47 INFO - 'sessionrestore_no_auto_restore', 05:52:47 INFO - 'tabpaint']}, 05:52:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:52:47 INFO - 'ts_paint', 05:52:47 INFO - 'tpaint', 05:52:47 INFO - 'sessionrestore', 05:52:47 INFO - 'sessionrestore_no_auto_restore', 05:52:47 INFO - 'tabpaint']}, 05:52:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['a11yr', 05:52:47 INFO - 'ts_paint', 05:52:47 INFO - 'tpaint', 05:52:47 INFO - 'sessionrestore', 05:52:47 INFO - 'sessionrestore_no_auto_restore', 05:52:47 INFO - 'tabpaint']}, 05:52:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['a11yr', 05:52:47 INFO - 'ts_paint', 05:52:47 INFO - 'tpaint', 05:52:47 INFO - 'sessionrestore', 05:52:47 INFO - 'sessionrestore_no_auto_restore', 05:52:47 INFO - 'tabpaint']}, 05:52:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['tsvgx', 05:52:47 INFO - 'tsvgr_opacity', 05:52:47 INFO - 'tart', 05:52:47 INFO - 'tscrollx', 05:52:47 INFO - 'cart', 05:52:47 INFO - 'tsvg_static']}, 05:52:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:52:47 INFO - 'tsvgr_opacity', 05:52:47 INFO - 'tart', 05:52:47 INFO - 'tscrollx', 05:52:47 INFO - 'cart', 05:52:47 INFO - 'tsvg_static']}, 05:52:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:52:47 INFO - 'talos_options': ['--disable-e10s'], 05:52:47 INFO - 'tests': ['tp5o']}, 05:52:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:52:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:52:47 INFO - 'talos_options': ['--disable-e10s', 05:52:47 INFO - '--xperf_path', 05:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:47 INFO - 'tests': ['tp5n']}, 05:52:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:52:47 INFO - 'talos_options': ['--xperf_path', 05:52:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:52:47 INFO - 'tests': ['tp5n']}}, 05:52:47 INFO - 'talos.zip': {'path': '', 05:52:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:52:47 INFO - Running post-action listener: _resource_record_post_action 05:52:47 INFO - [mozharness: 2017-03-09 13:52:47.749283Z] Finished populate-webroot step (success) 05:52:47 INFO - [mozharness: 2017-03-09 13:52:47.749400Z] Running create-virtualenv step. 05:52:47 INFO - Running pre-action listener: _resource_record_pre_action 05:52:47 INFO - Running main action method: create_virtualenv 05:52:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:52:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:52:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:52:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:52:47 INFO - Using real prefix '/tools/python27' 05:52:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:52:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:52:51 INFO - Installing pip.................done. 05:52:51 INFO - Return code: 0 05:52:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:52:51 INFO - Reading from file tmpfile_stdout 05:52:51 INFO - Output received: 05:52:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:52:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:52:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:52:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:52:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:51 INFO - 'HOME': '/Users/cltbld', 05:52:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:51 INFO - 'LOGNAME': 'cltbld', 05:52:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:51 INFO - 'MOZ_NO_REMOTE': '1', 05:52:51 INFO - 'NO_EM_RESTART': '1', 05:52:51 INFO - 'PAGER': '/bin/cat', 05:52:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:51 INFO - 'PWD': '/builds/slave/test', 05:52:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:51 INFO - 'SHELL': '/bin/bash', 05:52:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:52:51 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:52:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:51 INFO - 'USER': 'cltbld', 05:52:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:51 INFO - 'XPC_FLAGS': '0x0', 05:52:51 INFO - 'XPC_SERVICE_NAME': '0', 05:52:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:52:51 INFO - Cleaning up... 05:52:52 INFO - Return code: 0 05:52:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52:52 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 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:52:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:52:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:52:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:52 INFO - 'HOME': '/Users/cltbld', 05:52:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:52 INFO - 'LOGNAME': 'cltbld', 05:52:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:52 INFO - 'MOZ_NO_REMOTE': '1', 05:52:52 INFO - 'NO_EM_RESTART': '1', 05:52:52 INFO - 'PAGER': '/bin/cat', 05:52:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:52 INFO - 'PWD': '/builds/slave/test', 05:52:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:52 INFO - 'SHELL': '/bin/bash', 05:52:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:52:52 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:52:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:52 INFO - 'USER': 'cltbld', 05:52:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:52 INFO - 'XPC_FLAGS': '0x0', 05:52:52 INFO - 'XPC_SERVICE_NAME': '0', 05:52:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:52 INFO - Downloading/unpacking psutil>=3.1.1 05:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:52:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:55 INFO - Installing collected packages: psutil 05:52:55 INFO - Running setup.py install for psutil 05:52:55 INFO - building 'psutil._psutil_osx' extension 05:52:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:52:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:52:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:52:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:52:56 INFO - building 'psutil._psutil_posix' extension 05:52:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:52:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:52:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:52:56 INFO - ^ 05:52:56 INFO - 1 warning generated. 05:52:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:52:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:52:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:52:56 INFO - Successfully installed psutil 05:52:56 INFO - Cleaning up... 05:52:56 INFO - Return code: 0 05:52:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:52: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')]} 05:52:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:52:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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')]} 05:52:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:52:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:52: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:52: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:52: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 mozsystemmonitor==0.3 05:52:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:52:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:52:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:52:56 INFO - 'HOME': '/Users/cltbld', 05:52:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:52:56 INFO - 'LOGNAME': 'cltbld', 05:52:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:52:56 INFO - 'MOZ_NO_REMOTE': '1', 05:52:56 INFO - 'NO_EM_RESTART': '1', 05:52:56 INFO - 'PAGER': '/bin/cat', 05:52:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:52:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:52:56 INFO - 'PWD': '/builds/slave/test', 05:52:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:52:56 INFO - 'SHELL': '/bin/bash', 05:52:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:52:56 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:52:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:52:56 INFO - 'USER': 'cltbld', 05:52:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:52:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:52:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:52:56 INFO - 'XPC_FLAGS': '0x0', 05:52:56 INFO - 'XPC_SERVICE_NAME': '0', 05:52:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:52:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:52:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:52:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:52:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:52:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:52:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:52:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:52:59 INFO - Installing collected packages: mozsystemmonitor 05:52:59 INFO - Running setup.py install for mozsystemmonitor 05:53:00 INFO - Successfully installed mozsystemmonitor 05:53:00 INFO - Cleaning up... 05:53:00 INFO - Return code: 0 05:53:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:01 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 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:53:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:53:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:53:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:01 INFO - 'HOME': '/Users/cltbld', 05:53:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:01 INFO - 'LOGNAME': 'cltbld', 05:53:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:01 INFO - 'MOZ_NO_REMOTE': '1', 05:53:01 INFO - 'NO_EM_RESTART': '1', 05:53:01 INFO - 'PAGER': '/bin/cat', 05:53:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:01 INFO - 'PWD': '/builds/slave/test', 05:53:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:01 INFO - 'SHELL': '/bin/bash', 05:53:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:53:01 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:01 INFO - 'USER': 'cltbld', 05:53:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:01 INFO - 'XPC_FLAGS': '0x0', 05:53:01 INFO - 'XPC_SERVICE_NAME': '0', 05:53:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:01 INFO - Downloading/unpacking jsonschema==2.5.1 05:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:04 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:05 INFO - warning: no files found matching '*.txt' 05:53:05 INFO - no previously-included directories found matching 'build' 05:53:05 INFO - no previously-included directories found matching 'dist' 05:53:05 INFO - no previously-included directories found matching '.git*' 05:53:05 INFO - Installing collected packages: jsonschema, functools32 05:53:05 INFO - Running setup.py install for functools32 05:53:05 INFO - warning: no files found matching '*.txt' 05:53:05 INFO - no previously-included directories found matching 'build' 05:53:05 INFO - no previously-included directories found matching 'dist' 05:53:05 INFO - no previously-included directories found matching '.git*' 05:53:05 INFO - Successfully installed jsonschema functools32 05:53:05 INFO - Cleaning up... 05:53:05 INFO - Return code: 0 05:53:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:05 INFO - 'HOME': '/Users/cltbld', 05:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:05 INFO - 'LOGNAME': 'cltbld', 05:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:05 INFO - 'MOZ_NO_REMOTE': '1', 05:53:05 INFO - 'NO_EM_RESTART': '1', 05:53:05 INFO - 'PAGER': '/bin/cat', 05:53:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:05 INFO - 'PWD': '/builds/slave/test', 05:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:05 INFO - 'SHELL': '/bin/bash', 05:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:53:05 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:05 INFO - 'USER': 'cltbld', 05:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:05 INFO - 'XPC_FLAGS': '0x0', 05:53:05 INFO - 'XPC_SERVICE_NAME': '0', 05:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:05 INFO - Cleaning up... 05:53:05 INFO - Return code: 0 05:53:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:53:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:53:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:53:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:05 INFO - 'HOME': '/Users/cltbld', 05:53:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:05 INFO - 'LOGNAME': 'cltbld', 05:53:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:05 INFO - 'MOZ_NO_REMOTE': '1', 05:53:05 INFO - 'NO_EM_RESTART': '1', 05:53:05 INFO - 'PAGER': '/bin/cat', 05:53:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:05 INFO - 'PWD': '/builds/slave/test', 05:53:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:05 INFO - 'SHELL': '/bin/bash', 05:53:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:53:05 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:05 INFO - 'USER': 'cltbld', 05:53:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:05 INFO - 'XPC_FLAGS': '0x0', 05:53:05 INFO - 'XPC_SERVICE_NAME': '0', 05:53:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:05 INFO - Downloading/unpacking blobuploader==1.2.4 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:08 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:09 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - Downloading docopt-0.6.1.tar.gz 05:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:09 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:09 INFO - Running setup.py install for blobuploader 05:53:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:09 INFO - Running setup.py install for requests 05:53:10 INFO - Running setup.py install for docopt 05:53:10 INFO - Successfully installed blobuploader requests docopt 05:53:10 INFO - Cleaning up... 05:53:10 INFO - Return code: 0 05:53:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:10 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 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:53:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:10 INFO - 'HOME': '/Users/cltbld', 05:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:10 INFO - 'LOGNAME': 'cltbld', 05:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:10 INFO - 'MOZ_NO_REMOTE': '1', 05:53:10 INFO - 'NO_EM_RESTART': '1', 05:53:10 INFO - 'PAGER': '/bin/cat', 05:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:10 INFO - 'PWD': '/builds/slave/test', 05:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:10 INFO - 'SHELL': '/bin/bash', 05:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:53:10 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:10 INFO - 'USER': 'cltbld', 05:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:10 INFO - 'XPC_FLAGS': '0x0', 05:53:10 INFO - 'XPC_SERVICE_NAME': '0', 05:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:10 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-FY4LLb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-X0jqxt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-sdAS_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-t2h3rz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-3JJD77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-O700Pn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-zQxxgB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-dgVtgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-6bQQNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-_x7arl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:11 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-KmmSLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:12 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-hbNCYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:12 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-PViPrT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:12 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-zdp6YS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:12 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-VvdJOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:12 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-_6Bpwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:12 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-hGV2xY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:12 INFO - Running setup.py install for manifestparser 05:53:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:12 INFO - Running setup.py install for mozcrash 05:53:13 INFO - Running setup.py install for mozdebug 05:53:13 INFO - Running setup.py install for mozdevice 05:53:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Running setup.py install for mozfile 05:53:13 INFO - Running setup.py install for mozhttpd 05:53:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Running setup.py install for mozinfo 05:53:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Running setup.py install for mozInstall 05:53:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:13 INFO - Running setup.py install for mozleak 05:53:14 INFO - Running setup.py install for mozlog 05:53:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:14 INFO - Running setup.py install for moznetwork 05:53:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:14 INFO - Running setup.py install for mozprocess 05:53:14 INFO - Running setup.py install for mozprofile 05:53:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:14 INFO - Running setup.py install for mozrunner 05:53:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:14 INFO - Running setup.py install for mozscreenshot 05:53:15 INFO - Running setup.py install for moztest 05:53:15 INFO - Running setup.py install for mozversion 05:53:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:15 INFO - Cleaning up... 05:53:15 INFO - Return code: 0 05:53:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:15 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 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:53:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:53:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:15 INFO - 'HOME': '/Users/cltbld', 05:53:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:15 INFO - 'LOGNAME': 'cltbld', 05:53:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:15 INFO - 'MOZ_NO_REMOTE': '1', 05:53:15 INFO - 'NO_EM_RESTART': '1', 05:53:15 INFO - 'PAGER': '/bin/cat', 05:53:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:15 INFO - 'PWD': '/builds/slave/test', 05:53:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:15 INFO - 'SHELL': '/bin/bash', 05:53:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:53:15 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:15 INFO - 'USER': 'cltbld', 05:53:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:15 INFO - 'XPC_FLAGS': '0x0', 05:53:15 INFO - 'XPC_SERVICE_NAME': '0', 05:53:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:15 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-kwbEOs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:15 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-q7z_Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:15 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-mzZMsR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:15 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-GDnVec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:16 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-a3tdX8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:16 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-73sMwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:16 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-Tzot4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:16 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-vZ4Yf7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:16 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-47FOBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:16 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-xSSZDP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:16 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-rU2uwU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:16 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-FzgpmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:16 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-pOjlGo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:17 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-TqeLUc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:17 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-WMugLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:17 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-SYsDhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:17 INFO - Running setup.py (path:/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/pip-HtgkAF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:19 INFO - Downloading blessings-1.6.tar.gz 05:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:20 INFO - Installing collected packages: blessings 05:53:20 INFO - Running setup.py install for blessings 05:53:20 INFO - Successfully installed blessings 05:53:20 INFO - Cleaning up... 05:53:20 INFO - Return code: 0 05:53:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:20 INFO - Reading from file tmpfile_stdout 05:53:20 INFO - Current package versions: 05:53:20 INFO - blessings == 1.6 05:53:20 INFO - blobuploader == 1.2.4 05:53:20 INFO - docopt == 0.6.1 05:53:20 INFO - functools32 == 3.2.3-2 05:53:20 INFO - jsonschema == 2.5.1 05:53:20 INFO - manifestparser == 1.1 05:53:20 INFO - mozInstall == 1.12 05:53:20 INFO - mozcrash == 1.0 05:53:20 INFO - mozdebug == 0.1 05:53:20 INFO - mozdevice == 0.49 05:53:20 INFO - mozfile == 1.2 05:53:20 INFO - mozhttpd == 0.7 05:53:20 INFO - mozinfo == 0.9 05:53:20 INFO - mozleak == 0.1 05:53:20 INFO - mozlog == 3.4 05:53:20 INFO - moznetwork == 0.27 05:53:20 INFO - mozprocess == 0.25 05:53:20 INFO - mozprofile == 0.28 05:53:20 INFO - mozrunner == 6.13 05:53:20 INFO - mozscreenshot == 0.1 05:53:20 INFO - mozsystemmonitor == 0.3 05:53:20 INFO - moztest == 0.8 05:53:20 INFO - mozversion == 1.4 05:53:20 INFO - psutil == 3.1.1 05:53:20 INFO - requests == 1.2.3 05:53:20 INFO - wsgiref == 0.1.2 05:53:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:20 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 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:20 INFO - 'HOME': '/Users/cltbld', 05:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:20 INFO - 'LOGNAME': 'cltbld', 05:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:20 INFO - 'MOZ_NO_REMOTE': '1', 05:53:20 INFO - 'NO_EM_RESTART': '1', 05:53:20 INFO - 'PAGER': '/bin/cat', 05:53:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:20 INFO - 'PWD': '/builds/slave/test', 05:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:20 INFO - 'SHELL': '/bin/bash', 05:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:53:20 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:20 INFO - 'USER': 'cltbld', 05:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:20 INFO - 'XPC_FLAGS': '0x0', 05:53:20 INFO - 'XPC_SERVICE_NAME': '0', 05:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:53:20 INFO - Cleaning up... 05:53:20 INFO - Return code: 0 05:53:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:20 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 0x110392b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110395768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff3bb580f70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, '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.xs98sMBB3m/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.4aODVN5QI8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:53:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:53:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:20 INFO - 'HOME': '/Users/cltbld', 05:53:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:20 INFO - 'LOGNAME': 'cltbld', 05:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:20 INFO - 'MOZ_NO_REMOTE': '1', 05:53:20 INFO - 'NO_EM_RESTART': '1', 05:53:20 INFO - 'PAGER': '/bin/cat', 05:53:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:20 INFO - 'PWD': '/builds/slave/test', 05:53:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:20 INFO - 'SHELL': '/bin/bash', 05:53:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:53:20 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:20 INFO - 'USER': 'cltbld', 05:53:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:20 INFO - 'XPC_FLAGS': '0x0', 05:53:20 INFO - 'XPC_SERVICE_NAME': '0', 05:53:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:21 INFO - Cleaning up... 05:53:21 INFO - Return code: 0 05:53:21 INFO - Running post-action listener: _resource_record_post_action 05:53:21 INFO - Running post-action listener: _start_resource_monitoring 05:53:21 INFO - Starting resource monitoring. 05:53:21 INFO - [mozharness: 2017-03-09 13:53:21.177147Z] Finished create-virtualenv step (success) 05:53:21 INFO - [mozharness: 2017-03-09 13:53:21.178161Z] Running install step. 05:53:21 INFO - Running pre-action listener: _resource_record_pre_action 05:53:21 INFO - Running main action method: install 05:53:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:21 INFO - Reading from file tmpfile_stdout 05:53:21 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:21 INFO - Reading from file tmpfile_stdout 05:53:21 INFO - Output received: 05:53:21 INFO - Usage: mozinstall [options] installer 05:53:21 INFO - Options: 05:53:21 INFO - -h, --help show this help message and exit 05:53:21 INFO - -d DEST, --destination=DEST 05:53:21 INFO - Directory to install application into. [default: 05:53:21 INFO - "/builds/slave/test"] 05:53:21 INFO - --app=APP Application being installed. [default: firefox] 05:53:21 INFO - mkdir: /builds/slave/test/build/application 05:53:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:53:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:53:41 INFO - Reading from file tmpfile_stdout 05:53:41 INFO - Output received: 05:53:41 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:53:41 INFO - Running post-action listener: _resource_record_post_action 05:53:41 INFO - [mozharness: 2017-03-09 13:53:41.788537Z] Finished install step (success) 05:53:41 INFO - [mozharness: 2017-03-09 13:53:41.788697Z] Running run-tests step. 05:53:41 INFO - Running pre-action listener: _resource_record_pre_action 05:53:41 INFO - Running main action method: run_tests 05:53:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:41 INFO - 2017-03-09 05:53:41.803 screenresolution[1626:7295] starting screenresolution argv=screenresolution get 05:53:41 INFO - 2017-03-09 05:53:41.806 screenresolution[1626:7295] Display 0: 1600x1200x32@60 05:53:41 INFO - 2017-03-09 05:53:41.811 screenresolution[1627:7297] starting screenresolution argv=screenresolution list 05:53:41 INFO - Available Modes on Display 0 05:53:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:42 INFO - Intel Iris: 05:53:42 INFO - Chipset Model: Intel Iris 05:53:42 INFO - Type: GPU 05:53:42 INFO - Bus: Built-In 05:53:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:42 INFO - Vendor: Intel (0x8086) 05:53:42 INFO - Device ID: 0x0a2e 05:53:42 INFO - Revision ID: 0x0009 05:53:42 INFO - Displays: 05:53:42 INFO - Display: 05:53:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:42 INFO - Display Serial Number: 1600x1200 60 05:53:42 INFO - Main Display: Yes 05:53:42 INFO - Mirror: Off 05:53:42 INFO - Online: Yes 05:53:42 INFO - Rotation: Supported 05:53:42 INFO - Return code: 0 05:53:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:42 INFO - Python 2.7.3 05:53:42 INFO - Return code: 0 05:53:42 INFO - grabbing minidump binary from tooltool 05:53:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x110170d30>, '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 0x110097db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110165be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:53:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:53:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:53:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:42 INFO - Return code: 0 05:53:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:53:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:42 INFO - ENV: RUST_BACKTRACE is now 1 05:53:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:53:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:42 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:53:42 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0244 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:53:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xs98sMBB3m/Render', 05:53:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:42 INFO - 'HOME': '/Users/cltbld', 05:53:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:42 INFO - 'LOGNAME': 'cltbld', 05:53:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:53:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:42 INFO - 'MOZ_NO_REMOTE': '1', 05:53:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:42 INFO - 'NO_EM_RESTART': '1', 05:53:42 INFO - 'PAGER': '/bin/cat', 05:53:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:42 INFO - 'PWD': '/builds/slave/test', 05:53:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:42 INFO - 'RUST_BACKTRACE': '1', 05:53:42 INFO - 'SHELL': '/bin/bash', 05:53:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.4aODVN5QI8/Listeners', 05:53:42 INFO - 'TMPDIR': '/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/', 05:53:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:42 INFO - 'USER': 'cltbld', 05:53:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:42 INFO - 'XPC_FLAGS': '0x0', 05:53:42 INFO - 'XPC_SERVICE_NAME': '0', 05:53:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:42 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0244', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:53:42 INFO - mozversion application_buildid: 20170309030216 05:53:42 INFO - mozversion application_changeset: c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 05:53:42 INFO - mozversion application_display_name: Nightly 05:53:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:42 INFO - mozversion application_name: Firefox 05:53:42 INFO - mozversion application_remotingname: firefox 05:53:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:53:42 INFO - mozversion application_vendor: Mozilla 05:53:42 INFO - mozversion application_version: 55.0a1 05:53:42 INFO - mozversion platform_buildid: 20170309030216 05:53:42 INFO - mozversion platform_changeset: c40ca7a1bdd93632c6bdc5e23bd33d984d508b19 05:53:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:53:42 INFO - mozversion platform_version: 55.0a1 05:53:42 INFO - using testdate: 1489067622 05:53:42 INFO - actual date: 1489067622 05:53:42 INFO - starting webserver on 'localhost:49241' 05:53:42 INFO - SUITE-START | Running 2 tests 05:53:42 INFO - TEST-START | dromaeo_css 05:53:42 INFO - operating with platform_type : mac_ 05:53:42 INFO - Initialising browser for dromaeo_css test... 05:53:42 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpwFPIpG/profile http://localhost:49241/getInfo.html) 05:53:45 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 05:53:45 INFO - PROCESS | 1637 | colorDepth:24 05:53:45 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 05:53:45 INFO - PROCESS | 1637 | __metrics 05:53:45 INFO - PROCESS | 1637 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:53:45 INFO - PROCESS | 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:46 INFO - TEST-INFO | 1637: exit 0 05:53:46 INFO - Browser initialized. 05:53:46 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:46 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpwFPIpG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:53:58 INFO - PROCESS | 1640 | RSS: Main: 233078784 05:53:58 INFO - PROCESS | 1640 | 05:57:03 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 05:57:06 INFO - PROCESS | 1640 | RSS: Main: 467169280 05:57:06 INFO - PROCESS | 1640 | 05:58:48 INFO - PROCESS | 1640 | ************************* 05:58:48 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 05:58:48 INFO - PROCESS | 1640 | 05:58:48 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:58:48 INFO - PROCESS | 1640 | Full stack: 05:58:48 INFO - PROCESS | 1640 | ************************* 06:00:09 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 06:00:10 INFO - PROCESS | 1640 | RSS: Main: 364830720 06:00:10 INFO - PROCESS | 1640 | 06:03:12 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 06:03:13 INFO - PROCESS | 1640 | RSS: Main: 357343232 06:03:13 INFO - PROCESS | 1640 | 06:06:15 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 06:06:16 INFO - PROCESS | 1640 | RSS: Main: 345161728 06:06:16 INFO - PROCESS | 1640 | 06:09:20 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 06:09:20 INFO - PROCESS | 1640 | RSS: Main: 356020224 06:09:20 INFO - PROCESS | 1640 | 06:12:24 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 06:12:24 INFO - PROCESS | 1640 | RSS: Main: 607797248 06:12:24 INFO - PROCESS | 1640 | 06:12:24 INFO - PROCESS | 1640 | __start_tp_report 06:12:24 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 06:12:24 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 06:12:24 INFO - PROCESS | 1640 | |i|pagename|runs| 06:12:24 INFO - PROCESS | 1640 | |0;dojo.html;3249.2039450334655;3374.4938259261116;3379.864805407784;3385.0691059958517;3392.457206846905;5657.038303488406;5756.107803290497;5854;5947.553933454992;6001.429864162903;5787.971060144693;5854.414558544144;5900.586958912878;5905.0847118696565;5954.761809527614;5182.844514664566;5235.685858848462;5249.1338929076655;5259.579233661298;5270.5520030797425;5379.5696344292555;5395.05586522357;5402.432744561824;5421.159720243369;5452.40023597404;5176.870578235536;5216.2958000669805;5233.842984710464;5309.787608495636;5349.7057661828585;5219.634625576211;5228.633995620308;5250.868728281824;5253.684778913277;5255.237990491396;5154.613403994716;5194.4026436959475;5206.401263854667;5231;5247.2653828464045;5754.395788442237;5759.510441612468;5761.452661997104;5773.826785196451;5779.9422005779825;6212.9068063979075;6216.222972128484;6220.129181914535;6227.190465239535;6231.096491008823;6132.6013809102715;6193.194884665009;6222.844428889269;6223.25320961483;6239.812805615838;5898.793542226002;5902.380250073767;5925.022371308729;5959.880802383928;5997.370276121032;6385.8722825544155;6426.710798014101;6428.164338636041;6428.389303016206;6443.162388889508;6100.115483254903;6126.895025200522;6171.47542458896;6259.4679452246155;6261.436470717657;6207.96896015517;6217.533684973645;6222.066689996536;6230.065490176419;6230.750769969241;6189.226346706661;6191.628502289877;6206.503479721611;6207.379262073757;6207.596506227081;5586.581006424534;6178;6194.225721784777;6200.286966998763;6213.068039793977;4355.5208927018;4901.779419926112;5000.000000000015;5006.549410553068;5009.7495125243595;4414.823407063745;4414.977925110354;4416.205083085011;4439.955600443955;4529.796159172845;5695.5443564514735;5824.854378640568;5961.791337303173;5964.343922168558;6033.939660603338;6228.069737610555;6271.43557079865;6271.686415679198;6272.2159730033745;6286.371362863677;5733.283339582552;5764.74058667361;5961.850953726105;5976.581639285208;5985.311689155803;5488.451154884479;5496.450354964471;5496.983058134178;5497.202905578669;5508.20131080999;5365.409804921455;6239.75040998355;6290.779822706183;6300.621962682254;6308.400701933309;3650.6349365064343;5378.462153784591;6247.3440288769025;6301.117843501822;6318.6840657965995;6482.54622176462;6498.480121590356;6514.73941042353;6516.315786842503;6527.412532872065;6148.354422785543;6175.752969881154;6222.657753823583;6285.057241413824;6290.842728931813;6257.906131407942;6263.96868015657;6268.059791031199;6270.6864656766065;6286.811395658137;6111.052786818051;6140.9078863816185;6148;6155.292141403616;6160.921838678124;6140.903050468011;6166.969165154145;6186.752529898754;6234.438900498977;6258.561900667091;6174.567780255339;6179.62922224668;6181.412765787243;6185.659788711664;6205.906911396423;6236.6258024518675;6262.311145774052;6262.499000079892;6275.246970363585;6276.623402595859;5948.821535353946;5991.520678345809;6093.9390606093375;6105.572609917263;6177.6911154443 06:12:24 INFO - PROCESS | 1640 | |1;ext.html;731.9634018299084;759.2445516710874;796.2952786783696;876.3120950054205;877.3156937588675;27597.448051038966;28540.429191416184;38694.41958370623;38887.61112388875;41197;38963.610363896354;39190;39349.21301573967;39358;39533.40699889497;8972.685955991541;9138;9140.954295228514;9151;9155;7284.417246620258;7454.1055073391;7521.172671006185;7523.285287897668;7532.472726909118;10706.464676766169;10896.836547451794;11016.228863979524;11054.060404865597;11062.612808551703;10787.78424431511;10848;10854.837177442385;10887.455627218687;10901.454927253684;7157.498975071747;10562.630307939262;10629.84055239172;10647.787044259072;10649.733756656067;27619.309517262027;27809.026684066164;27856.721432785816;37932.620673793186;38470.23059538793;3853.2871418787613;3854.4411060396087;3863.4357300852107;3870.8645197417954;3917.490726205575;27737.58393624097;27846.886124554992;27985.440291194063;28173.85913070442;28755.13734587966;2737.8494182819936;2948.0418863869113;3053.603031605899;3100.302431952815;3102.844857757103;347066;351881;353467.2326638376;354150;355381;41895.9526011846;51510.48489515132;51560.484395156316;51570.96858062818;51695.741521292155;44541.777291113336;44659.77670111629;44803.551964479935;49235.75382123067;49242.26136607954;14787;14859.702805944036;14881.479148229977;14881.949200413888;14886.553403397915;12079.57721479744;12250.938745306217;12281.324527150913;12287.017038636888;12315.384230788424;12925.095243333064;12925.482980680668;12960;13021.414036368385;13079.869201307865;4474.26174681174;5264.499872512105;5312.946870531323;5327.147656374961;5339.065663508871;1091.6179337231906;1097.2757979733337;1101.680512651322;1122.2144498850837;1174.48322737995;22540.774592253867;26292;26688.866555667486;26781.062662806708;27000.919963201253;1175.2243519277406;1193.4689063366718;1202.897753690946;1220.7558488302375;1267.1700036476122;12974.675633109058;13728;13879.838781552997;14028.368723407268;14053;368752;427123;428209;428612;428755;55301.72349138309;55366.89266214653;55418.44581554214;55425;55442.89114217693;1382.8962827787957;1431.7709166533514;1435.5980325508874;1437.583100900727;1440.3662388549005;17747.645047099242;25631.359216019748;25819.870900645376;25861;25935;45496.54503455055;45513;45609.771951140036;45630.31554526751;45709.62871113872;431104;432680;433069;433342;433583;27226.72773272242;28995.56506652444;33551.32897342088;33655.495167572015;35032;42819.357709633754;43826;43904.34143487914;44152;44417.777911110235;27992;32915.50626740553;34176.974690759314;35667.46498802572;36852;30700.46497675152;34441.277936103594;34826;35244.29511409809;36513;36031.459528107625;36073.27853442864;36129;36160.91517254487;37099.443508346856;31036.379272414877;32114.299913032675;32517.349653006335;32533.34933301368;32607.836960815042;24168.274951751475;24328.635070474313;24360.120821906865;24467.38831529226;24497.510049798548 06:12:24 INFO - PROCESS | 1640 | |2;jquery.html;384.4751913637885;396.6192455242967;411.5411316382235;416.79368712487326;442.11576846307383;12937.805932911002;19718.30985915493;20397.796022039776;21942;22437.663435048486;16265.349386024545;20861.68707469389;21531;22293.2197373092;22557.872106394698;5769.624974376673;6400.103985442053;6690.431313338372;6759.864802703943;6771.221309549391;6448.613083214998;7594.620268986529;7597.430192735539;7603.695852165907;7604.505707129047;7413.147488038863;7474.439417043716;7487;7564.962175189116;7606.809829754273;7411.740589079356;7444.292792184734;7493.925060749404;7505.362044226247;7719.575423351714;7358.77923662291;7598.810029749246;7635.580043097628;7642.121156067068;7647.235276472308;27592.586111208348;27772.861135694395;28457.430851383062;28461.00386486463;28549.714502854913;2887.7978541502102;2898.2464559214545;2900.3474218300926;2944.322805754667;3221.742260619168;15773.921130394388;16476.588085297964;16833.91583042089;16865.662686746196;17755.02347370894;2001.0695026812457;2038.2458490358515;2044.7444069491314;2049.9795002049937;2055.80469855365;154803;159728;160976;161419.1929040359;165997.08035035752;15551.377944882079;16567.337306507605;21805.563888722136;21881.67177492339;21993.120275188812;28770.993015244785;34337.48493772595;34717.78487752967;34751.826240868635;36215.27569448649;8575.656973720981;9025.864612030824;10346;10650.254482186327;10715.732106697238;8446.915530844735;8576.699815506552;8706.347023973101;8769.605367758466;8815.66384908;9192.172704456498;10425.218108641882;10570.207234457446;10634.30876992993;10787.137029037658;4208.431861698631;4258.850940217078;4282.207791558571;4292.570742925683;4318.5033721121845;857.7341024282492;862.9515139105891;923.5013092929743;924.2882980105281;941.7928055827844;21775.346739597837;23359.065637374315;23386.673465408952;23408.414789630056;23500.647490287658;897.869808877709;903.4398672822892;916.3631276262934;917.9678711245074;918.3250311021394;11777.941110294565;11907.34509601963;12239.449224784907;12251.693707657201;12257.816132758016;695519;697378;701060;719903;744205;149834.00663973318;151875;152729;154560;157911;1165.9533618655328;1196.7068068323317;1227.5151315230255;1231.359692959656;1235.4440501774238;19888.801111988694;19900.50248743793;20277.2902948402;20284;20414.877181755146;56641.716791415776;59655.81265347688;60509.39490605213;61848.9999999982;62647.37352626416;87312.56343718241;89394.65908011515;89834.55082724807;89909;91011.63482547899;10060.39637621745;10113.5448904798;12175.573854915036;12230.266184028987;12296.139270251355;13342.266175360448;13857.584272471842;13876.722465550834;14243.572692818818;14288.928555357572;10160;11702.414879255834;11964.401779910795;12013;12036.217645852992;11459.713507162387;11494.425278735862;11846.052315814886;11894.397760494072;11940.880591193976;11694.532218711156;11720.765584688088;11991.700207494534;12020.579279725167;12073.818892716792;11849.170558060852;11928;12216.75566488683;12261.632151035483;12280.263184208976;11501.252418592765;11549.133814963743;11934.820977685515;11948.522059117886;11995.700107497034 06:12:24 INFO - PROCESS | 1640 | |3;mootools.html;1563.2105786577777;1573.6931298396803;1580.2572790788329;1594.6252630631807;1599.1604407685963;10465.31975421598;11066.778664426707;11074.612388566402;11075.224734268615;11077.778444431116;10578.047975682188;10987.285826421277;11190.888091119086;11193.328400295988;11201.495932683029;2325.2559181062065;2371.1937941100023;2371.9644205336936;2372.1578839511985;2373.394784330002;2302.654601809725;2331.80179684727;2334.9182778602753;2340.508493216427;2345.4839935214227;2306.8581052379095;2322.1756276521846;2324.337563794319;2333.7666233376613;2334.743178250391;2257.266388423769;2282.8287878409187;2286.3826766772963;2286.7484576696465;2291.5531471363092;2248.033345661365;2303.3761198355287;2306.411864974438;2306.5848147333472;2308.699869017034;9562.091601297865;10971.890281097167;11000.284981476178;11110.44447777616;11169.385683787388;5501.174823776426;5675.318961724578;5676.091825307931;5683.090705487102;5683.090705487143;3292.884749033772;3402.3705614461405;3583.380785406732;3585.995921142084;3600.5859326177565;1101.895319944604;1103.382106020631;1104.276698762312;1119.7312644965232;1225.4118023348842;14973.401063957428;15016.849831501655;15081.54755357341;15107.848921510864;15127.621809454742;3959.247742928834;4266.978665106654;4497.100579884036;4581;4586.334981427741;9648.903510964941;11173.385463799406;11223.494942727597;11235.325880447199;11262.943685281522;5512.80705175317;5513.448655134454;5513.61404701667;5521.723913804374;5538.86152846174;4873.634477414208;4890.510948905081;5072.695638261716;5084.3644544431945;5210.843674689765;3593.13764696471;3666.4866918631415;3678.5953545110015;3723.404255319136;3733.9439908401396;1000.7748256642197;1002.1231422505308;1010.3230835340339;1017.1151098544166;1020.7958408318366;877.6401675313218;911.4303560274828;918.9908100919039;943.9993606776701;950.9524523773783;6386.137871387304;6460.418562329319;6476.125723027425;6503.772367967098;6527.834598920354;900.2213085680839;925.153484561632;949.8955114937352;983.6163896080534;997.6458357283205;3804.239152169577;3879.6702280305926;3931.8623848165175;4043.3732771420478;4050.594940505926;12885.291308977909;13190.406431710597;13388;13435.059545831893;13452.394642241123;11787.174897757246;13276.26980516081;13295.401706923212;13314.800277995837;13315.66710832237;7354.264573542603;8495.447795893371;8567.858035491126;8671.566421679017;8832.5583720815;5516.641418307797;6376.808695739135;6505.316941721051;6597.3072827352435;6685.6322902240845;11174.832377514507;11807.291562506278;11856.881431185579;11857.940710296394;11888.34614096233;11849.940750296193;11975.880241197476;11975.940120299343;12168.817467738168;12352.938235308766;8202.302804261704;8236.794080147805;8311.6675332986;8316.5425901576;8333.458325208841;7981;9584.856227156737;10014.94992525062;10041;10126.24053196028;8841.867371989554;8951.865722014045;9006.909930900869;9161.908380916373;9169.128932751379;8696.956515217636;8813.383063185516;8815.647374104963;8922.286217102746;9054.864177037218;7467.962660186664;7597.392208623186;7719.4210434218785;7721.266479684421;7736.613169341623;5605.159226116115;5778.94221057784;5782.479576838105;5855.560832937462;5906.557008224315;5759;5882.852928676646;5900.734466949083;5909.349971503218;5957.374475680164 06:12:24 INFO - PROCESS | 1640 | |4;prototype.html;376.1442717816967;377.71482530689326;382.45118255303623;389.1341764573823;391.71209161266466;4434.935615452292;4528.479224889139;4823.204171311734;4848.878778030551;4861;4191.910103373122;4501.684882058257;4613.354130421743;4757.571818536331;4813.181759100952;3630.8547658093644;3841.5390153181656;3967.6032396760384;4042.373432118019;4051.493563304587;3483.4078206704794;3996.560378358393;4015.5382131054866;4046.5751096134923;4063.5936406359424;3634.6547078027547;4062.4718786557855;4074.633283004529;4102.897427564305;4124.237016152021;3300.785448945835;3442.862285508589;3464.5149679044953;3774.6602805747475;4057.939130913009;3512.631173726773;3606.855725770966;3733.4399840023943;3738.12154143776;3766.3785475396526;3858.6913046956174;4627.676062675614;4678.1813182692895;4729.62163026957;4802.639802014863;4341.696081274312;4660.277656963176;4729.739864307462;4735.455422626374;4735.786889589976;5099.46455622158;5163.741812909339;5176.870578235536;5199.272101905736;5223.503767142115;3754.418065199871;3855.8650447234213;4129.648979836717;4158.875233742992;4165.625093741578;4512.796924138389;4516.36770852081;4877.34155888954;5154.793808247666;5275.956597941752;4077.1234184649848;4202.306619407764;4204.201201771653;4228.8010234677795;4242.66058715302;3820.178661587772;3869.2481619574023;4093.85671501496;4275.957240427618;4333.306670932636;4234.38601402801;4339.674524410681;4446.911061778811;4640.419947506562;4689.6717229793585;4196.874093777131;4898.4121905371585;4951.653384263067;5051.949480505222;5138.922916156261;1244.6433387607551;1437.1448987852211;1450.840407555168;1455.4542046732474;1462.1722846441949;938.1931538876561;1082.0856376361962;1106.1482658353184;1117.591834288802;1126.3523474002482;4460.576245256695;4738.384010078667;4766.737829419415;4828.46886842447;5059.316992206005;4331.025519258142;4954.950450495521;5194.610404219623;5322.973385133049;5328.813491527778;4096.631303182728;4541.8183272669385;4750;4809.687370320918;4824.035192961422;2545.656336394563;2619.7642212200612;2621.934451638686;2776.0428897627125;2786.5541513357766;5033.748312584356;5219.739013049332;5234.685918844882;5482.753276102585;5512.2558454608115;4506.81972721094;4844.588210002189;4954.677945933575;5464.3442786865035;5515.944840551623;4918.9508104919205;5426;5456.536194423518;5469.808556700496;5497.670139791625;4653.022865198346;4719.882002949954;4876;5113.360829896263;5187.58499320061;4248.745075295492;4873.390826146731;5116.316252298339;5202.843914682566;5288.788448462018;4636.675432719677;5005.824796132118;5295.417504074626;5520.503154716095;5524.917126243029;3750.943735844019;3765.868194613285;4244.596763307481;4251.766152861499;4277.871663850089;4636.536346365471;4921.040397122527;5063.620228482805;5305.31030965972;5346.572274218131;4746.315058154443;5085.720285384339;5112.872178195575;5114.820981265638;5257.8159764408065;4350.456192975878;4631.93052104212;4953.578945789648;5150.40770311419;5159.716215608178;4305.256371169681;4688.990912769669;4848.981713839992;4992.600591952708;4995.650304478797;4539.636829053734;4624;4798.448178459522;4936.7910857942625;5128.435872053997;4542.18240716661;4564.448087650215;4677.415323084614;4679.742614156254;5064.569511591409 06:12:24 INFO - PROCESS | 1640 | |5;yui.html;705.6612825843595;709.3927379276379;729.3290173040799;743.5427212264456;757.481125429081;14898.404063837446;15416.922915385407;15818.288177032033;15831;16172.19139043046;14345.713085738278;14645.926770366133;14818.925905370485;14901.92549037256;14932.402703891832;911.7173676160412;950.8526178442353;952.4570994533119;954.4273435938451;958.9520523973808;929.8372784762673;945.9574319155655;948.8956214816365;949.0130264524886;981.8232718110737;1026.2046913641911;1031.8555402243692;1033.7570670892335;1034.5913364221128;1035.373598972622;1024.774549599087;1025.2208321675505;1026.1893104447477;1028.0695970147028;1031.3244824639874;730.2733779889045;731.579341878422;731.6378392695597;754.7660225330166;764.3503022430945;15671.294791734399;15856.445024424205;16105.194740263058;16129.516114516584;16221.513354599381;12386.876131238663;14297.571072867831;14353.78469322961;14561.708765824624;14670.853291467161;9632.518374081268;11490.425478726114;11577.710557236052;11826.403435536178;12157.93921030398;3683.318586061587;3728.4966529518438;3767.472553842437;3898.941515877264;3899.4345819856244;106042.40936385961;108342;109863;110044.4497777514;110109.89890101156;11218.508792075636;11315.773684526428;11375.772484550429;11834.892614300135;11884.524619015316;24823.882925268405;24853.378665533146;25051.498970020497;25073.62389564158;25094.372640683763;7614.6954121835615;7720.884186737204;7812.140664526897;7827.491213071246;7873.724419645285;3729.5524537055726;4171.124063946544;4228.70399072062;4253.787310634456;4350.847720329773;3453.913652158716;3516.7538272321203;3517.7889326640484;3526.0303416560137;3570.2145527983803;634.2895956528718;635.9427651511386;642.5919541091347;650.5771248688296;651.7555916531301;619.8884200843892;641.6535071061575;651.4592887903029;671.3655595462242;688.9379955804002;10043.799124017478;10045.921648991087;10098.899011009942;10205.183585313158;10331.483425828828;658.8649326887977;670.963097029668;680.8638272345452;689.1454596300551;693.4798900824381;4845.53967373099;4886.53577910098;4996.875078123076;4997.7251251180805;5015.097282489187;105364;105546;105557;106971;107219.46390267999;48397.758011210426;60086.39913600896;75273;81582.18417815864;89726.10273897178;66264.6686766563;69040;70738.29261707523;79292.4141517155;83398;9334.813303734023;10611.681649550526;10868.641419822523;10869.29349592274;11101.94449027782;45165.838391312296;45369;49431.25853112278;50143.49856501534;50997.7450112747;58493;66393.66803165953;69205.2698682537;69488;70248.6487567559;13529.661758456117;13747.656308592364;13919.373628186553;14002.36989335462;14038.438462461387;14107.506237281646;14613.780793288322;14627.19550424737;14904.329305181509;15147.621309467351;13291.460033193975;13442.798358024442;13783.586492405244;13802.240876751875;14153.08004979673;13677.24775137377;13746.737717444013;13880.236586987812;14269.001169918007;14289.268865576883;13130.570844393818;13387.397567109698;13395.196288222738;13457.906768710785;14323.14061156334;10298.794024119326;10639.308444951053;10867.84882537246;11048.447577621248;11073.446327683423;7370.651315723749;7717.498362606412;10752.946235268773;11278.774424511628;11296.6046188383 06:12:24 INFO - PROCESS | 1640 | __end_tp_report 06:12:24 INFO - PROCESS | 1640 | __start_cc_report 06:12:24 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2805 06:12:24 INFO - PROCESS | 1640 | __end_cc_report 06:12:24 INFO - PROCESS | 1640 | __startTimestamp1489068744534__endTimestamp 06:12:24 INFO - PROCESS | 1640 | 06:12:24 INFO - PROCESS | 1640 | ------- Summary: start ------- 06:12:24 INFO - PROCESS | 1640 | Number of tests: 6 06:12:24 INFO - PROCESS | 1640 | 06:12:24 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5789.12 Median:6100.12 stddev:674.22 (11.1%) stddev-sans-first:646.18 06:12:24 INFO - PROCESS | 1640 | Values: 3249.2 3374.5 3379.9 3385.1 3392.5 5657.0 5756.1 5854.0 5947.6 6001.4 5788.0 5854.4 5900.6 5905.1 5954.8 5182.8 5235.7 5249.1 5259.6 5270.6 5379.6 5395.1 5402.4 5421.2 5452.4 5176.9 5216.3 5233.8 5309.8 5349.7 5219.6 5228.6 5250.9 5253.7 5255.2 5154.6 5194.4 5206.4 5231.0 5247.3 5754.4 5759.5 5761.5 5773.8 5779.9 6212.9 6216.2 6220.1 6227.2 6231.1 6132.6 6193.2 6222.8 6223.3 6239.8 5898.8 5902.4 5925.0 5959.9 5997.4 6385.9 6426.7 6428.2 6428.4 6443.2 6100.1 6126.9 6171.5 6259.5 6261.4 6208.0 6217.5 6222.1 6230.1 6230.8 6189.2 6191.6 6206.5 6207.4 6207.6 5586.6 6178.0 6194.2 6200.3 6213.1 4355.5 4901.8 5000.0 5006.5 5009.7 4414.8 4415.0 4416.2 4440.0 4529.8 5695.5 5824.9 5961.8 5964.3 6033.9 6228.1 6271.4 6271.7 6272.2 6286.4 5733.3 5764.7 5961.9 5976.6 5985.3 5488.5 5496.5 5497.0 5497.2 5508.2 5365.4 6239.8 6290.8 6300.6 6308.4 3650.6 5378.5 6247.3 6301.1 6318.7 6482.5 6498.5 6514.7 6516.3 6527.4 6148.4 6175.8 6222.7 6285.1 6290.8 6257.9 6264.0 6268.1 6270.7 6286.8 6111.1 6140.9 6148.0 6155.3 6160.9 6140.9 6167.0 6186.8 6234.4 6258.6 6174.6 6179.6 6181.4 6185.7 6205.9 6236.6 6262.3 6262.5 6275.2 6276.6 5948.8 5991.5 6093.9 6105.6 6177.7 06:12:24 INFO - PROCESS | 1640 | 06:12:24 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:53828.31 Median:33916.23 stddev:106515.69 (314.1%) stddev-sans-first:106739.89 06:12:24 INFO - PROCESS | 1640 | Values: 732.0 759.2 796.3 876.3 877.3 27597.4 28540.4 38694.4 38887.6 41197.0 38963.6 39190.0 39349.2 39358.0 39533.4 8972.7 9138.0 9141.0 9151.0 9155.0 7284.4 7454.1 7521.2 7523.3 7532.5 10706.5 10896.8 11016.2 11054.1 11062.6 10787.8 10848.0 10854.8 10887.5 10901.5 7157.5 10562.6 10629.8 10647.8 10649.7 27619.3 27809.0 27856.7 37932.6 38470.2 3853.3 3854.4 3863.4 3870.9 3917.5 27737.6 27846.9 27985.4 28173.9 28755.1 2737.8 2948.0 3053.6 3100.3 3102.8 347066.0 351881.0 353467.2 354150.0 355381.0 41896.0 51510.5 51560.5 51571.0 51695.7 44541.8 44659.8 44803.6 49235.8 49242.3 14787.0 14859.7 14881.5 14881.9 14886.6 12079.6 12250.9 12281.3 12287.0 12315.4 12925.1 12925.5 12960.0 13021.4 13079.9 4474.3 5264.5 5312.9 5327.1 5339.1 1091.6 1097.3 1101.7 1122.2 1174.5 22540.8 26292.0 26688.9 26781.1 27000.9 1175.2 1193.5 1202.9 1220.8 1267.2 12974.7 13728.0 13879.8 14028.4 14053.0 368752.0 427123.0 428209.0 428612.0 428755.0 55301.7 55366.9 55418.4 55425.0 55442.9 1382.9 1431.8 1435.6 1437.6 1440.4 17747.6 25631.4 25819.9 25861.0 25935.0 45496.5 45513.0 45609.8 45630.3 45709.6 431104.0 432680.0 433069.0 433342.0 433583.0 27226.7 28995.6 33551.3 33655.5 35032.0 42819.4 43826.0 43904.3 44152.0 44417.8 27992.0 32915.5 34177.0 35667.5 36852.0 30700.5 34441.3 34826.0 35244.3 36513.0 36031.5 36073.3 36129.0 36160.9 37099.4 31036.4 32114.3 32517.3 32533.3 32607.8 24168.3 24328.6 24360.1 24467.4 24497.5 06:12:24 INFO - PROCESS | 1640 | 06:12:24 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:42541.04 Median:22365.44 stddev:119202.48 (533.0%) stddev-sans-first:119494.85 06:12:24 INFO - PROCESS | 1640 | Values: 384.5 396.6 411.5 416.8 442.1 12937.8 19718.3 20397.8 21942.0 22437.7 16265.3 20861.7 21531.0 22293.2 22557.9 5769.6 6400.1 6690.4 6759.9 6771.2 6448.6 7594.6 7597.4 7603.7 7604.5 7413.1 7474.4 7487.0 7565.0 7606.8 7411.7 7444.3 7493.9 7505.4 7719.6 7358.8 7598.8 7635.6 7642.1 7647.2 27592.6 27772.9 28457.4 28461.0 28549.7 2887.8 2898.2 2900.3 2944.3 3221.7 15773.9 16476.6 16833.9 16865.7 17755.0 2001.1 2038.2 2044.7 2050.0 2055.8 154803.0 159728.0 160976.0 161419.2 165997.1 15551.4 16567.3 21805.6 21881.7 21993.1 28771.0 34337.5 34717.8 34751.8 36215.3 8575.7 9025.9 10346.0 10650.3 10715.7 8446.9 8576.7 8706.3 8769.6 8815.7 9192.2 10425.2 10570.2 10634.3 10787.1 4208.4 4258.9 4282.2 4292.6 4318.5 857.7 863.0 923.5 924.3 941.8 21775.3 23359.1 23386.7 23408.4 23500.6 897.9 903.4 916.4 918.0 918.3 11777.9 11907.3 12239.4 12251.7 12257.8 695519.0 697378.0 701060.0 719903.0 744205.0 149834.0 151875.0 152729.0 154560.0 157911.0 1166.0 1196.7 1227.5 1231.4 1235.4 19888.8 19900.5 20277.3 20284.0 20414.9 56641.7 59655.8 60509.4 61849.0 62647.4 87312.6 89394.7 89834.6 89909.0 91011.6 10060.4 10113.5 12175.6 12230.3 12296.1 13342.3 13857.6 13876.7 14243.6 14288.9 10160.0 11702.4 11964.4 12013.0 12036.2 11459.7 11494.4 11846.1 11894.4 11940.9 11694.5 11720.8 11991.7 12020.6 12073.8 11849.2 11928.0 12216.8 12261.6 12280.3 11501.3 11549.1 11934.8 11948.5 11995.7 06:12:24 INFO - PROCESS | 1640 | 06:12:24 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6496.14 Median:3596.86 stddev:4076.02 (113.3%) stddev-sans-first:4070.61 06:12:24 INFO - PROCESS | 1640 | Values: 1563.2 1573.7 1580.3 1594.6 1599.2 10465.3 11066.8 11074.6 11075.2 11077.8 10578.0 10987.3 11190.9 11193.3 11201.5 2325.3 2371.2 2372.0 2372.2 2373.4 2302.7 2331.8 2334.9 2340.5 2345.5 2306.9 2322.2 2324.3 2333.8 2334.7 2257.3 2282.8 2286.4 2286.7 2291.6 2248.0 2303.4 2306.4 2306.6 2308.7 9562.1 10971.9 11000.3 11110.4 11169.4 5501.2 5675.3 5676.1 5683.1 5683.1 3292.9 3402.4 3583.4 3586.0 3600.6 1101.9 1103.4 1104.3 1119.7 1225.4 14973.4 15016.8 15081.5 15107.8 15127.6 3959.2 4267.0 4497.1 4581.0 4586.3 9648.9 11173.4 11223.5 11235.3 11262.9 5512.8 5513.4 5513.6 5521.7 5538.9 4873.6 4890.5 5072.7 5084.4 5210.8 3593.1 3666.5 3678.6 3723.4 3733.9 1000.8 1002.1 1010.3 1017.1 1020.8 877.6 911.4 919.0 944.0 951.0 6386.1 6460.4 6476.1 6503.8 6527.8 900.2 925.2 949.9 983.6 997.6 3804.2 3879.7 3931.9 4043.4 4050.6 12885.3 13190.4 13388.0 13435.1 13452.4 11787.2 13276.3 13295.4 13314.8 13315.7 7354.3 8495.4 8567.9 8671.6 8832.6 5516.6 6376.8 6505.3 6597.3 6685.6 11174.8 11807.3 11856.9 11857.9 11888.3 11849.9 11975.9 11975.9 12168.8 12352.9 8202.3 8236.8 8311.7 8316.5 8333.5 7981.0 9584.9 10014.9 10041.0 10126.2 8841.9 8951.9 9006.9 9161.9 9169.1 8697.0 8813.4 8815.6 8922.3 9054.9 7468.0 7597.4 7719.4 7721.3 7736.6 5605.2 5778.9 5782.5 5855.6 5906.6 5759.0 5882.9 5900.7 5909.3 5957.4 06:12:24 INFO - PROCESS | 1640 | 06:12:24 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4255.69 Median:4634.23 stddev:1171.21 (25.3%) stddev-sans-first:1137.72 06:12:24 INFO - PROCESS | 1640 | Values: 376.1 377.7 382.5 389.1 391.7 4434.9 4528.5 4823.2 4848.9 4861.0 4191.9 4501.7 4613.4 4757.6 4813.2 3630.9 3841.5 3967.6 4042.4 4051.5 3483.4 3996.6 4015.5 4046.6 4063.6 3634.7 4062.5 4074.6 4102.9 4124.2 3300.8 3442.9 3464.5 3774.7 4057.9 3512.6 3606.9 3733.4 3738.1 3766.4 3858.7 4627.7 4678.2 4729.6 4802.6 4341.7 4660.3 4729.7 4735.5 4735.8 5099.5 5163.7 5176.9 5199.3 5223.5 3754.4 3855.9 4129.6 4158.9 4165.6 4512.8 4516.4 4877.3 5154.8 5276.0 4077.1 4202.3 4204.2 4228.8 4242.7 3820.2 3869.2 4093.9 4276.0 4333.3 4234.4 4339.7 4446.9 4640.4 4689.7 4196.9 4898.4 4951.7 5051.9 5138.9 1244.6 1437.1 1450.8 1455.5 1462.2 938.2 1082.1 1106.1 1117.6 1126.4 4460.6 4738.4 4766.7 4828.5 5059.3 4331.0 4955.0 5194.6 5323.0 5328.8 4096.6 4541.8 4750.0 4809.7 4824.0 2545.7 2619.8 2621.9 2776.0 2786.6 5033.7 5219.7 5234.7 5482.8 5512.3 4506.8 4844.6 4954.7 5464.3 5515.9 4919.0 5426.0 5456.5 5469.8 5497.7 4653.0 4719.9 4876.0 5113.4 5187.6 4248.7 4873.4 5116.3 5202.8 5288.8 4636.7 5005.8 5295.4 5520.5 5524.9 3750.9 3765.9 4244.6 4251.8 4277.9 4636.5 4921.0 5063.6 5305.3 5346.6 4746.3 5085.7 5112.9 5114.8 5257.8 4350.5 4631.9 4953.6 5150.4 5159.7 4305.3 4689.0 4849.0 4992.6 4995.7 4539.6 4624.0 4798.4 4936.8 5128.4 4542.2 4564.4 4677.4 4679.7 5064.6 06:12:24 INFO - PROCESS | 1640 | 06:12:24 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20152.63 Median:20522.70 stddev:28654.07 (139.6%) stddev-sans-first:28697.25 06:12:24 INFO - PROCESS | 1640 | Values: 705.7 709.4 729.3 743.5 757.5 14898.4 15416.9 15818.3 15831.0 16172.2 14345.7 14645.9 14818.9 14901.9 14932.4 911.7 950.9 952.5 954.4 959.0 929.8 946.0 948.9 949.0 981.8 1026.2 1031.9 1033.8 1034.6 1035.4 1024.8 1025.2 1026.2 1028.1 1031.3 730.3 731.6 731.6 754.8 764.4 15671.3 15856.4 16105.2 16129.5 16221.5 12386.9 14297.6 14353.8 14561.7 14670.9 9632.5 11490.4 11577.7 11826.4 12157.9 3683.3 3728.5 3767.5 3898.9 3899.4 106042.4 108342.0 109863.0 110044.4 110109.9 11218.5 11315.8 11375.8 11834.9 11884.5 24823.9 24853.4 25051.5 25073.6 25094.4 7614.7 7720.9 7812.1 7827.5 7873.7 3729.6 4171.1 4228.7 4253.8 4350.8 3453.9 3516.8 3517.8 3526.0 3570.2 634.3 635.9 642.6 650.6 651.8 619.9 641.7 651.5 671.4 688.9 10043.8 10045.9 10098.9 10205.2 10331.5 658.9 671.0 680.9 689.1 693.5 4845.5 4886.5 4996.9 4997.7 5015.1 105364.0 105546.0 105557.0 106971.0 107219.5 48397.8 60086.4 75273.0 81582.2 89726.1 66264.7 69040.0 70738.3 79292.4 83398.0 9334.8 10611.7 10868.6 10869.3 11101.9 45165.8 45369.0 49431.3 50143.5 50997.7 58493.0 66393.7 69205.3 69488.0 70248.6 13529.7 13747.7 13919.4 14002.4 14038.4 14107.5 14613.8 14627.2 14904.3 15147.6 13291.5 13442.8 13783.6 13802.2 14153.1 13677.2 13746.7 13880.2 14269.0 14289.3 13130.6 13387.4 13395.2 13457.9 14323.1 10298.8 10639.3 10867.8 11048.4 11073.4 7370.7 7717.5 10752.9 11278.8 11296.6 06:12:24 INFO - PROCESS | 1640 | -------- Summary: end -------- 06:12:24 INFO - PROCESS | 1640 | 06:12:25 INFO - TEST-INFO | 1640: exit 0 06:12:25 INFO - TEST-OK | dromaeo_css | took 1122854ms 06:12:25 INFO - TEST-START | kraken 06:12:25 INFO - operating with platform_type : mac_ 06:12:25 INFO - Initialising browser for kraken test... 06:12:25 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpZD7ACR/profile http://localhost:49241/getInfo.html) 06:12:27 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 06:12:27 INFO - PROCESS | 1650 | colorDepth:24 06:12:27 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 06:12:27 INFO - PROCESS | 1650 | __metrics 06:12:27 INFO - PROCESS | 1650 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:12:27 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:28 INFO - TEST-INFO | 1650: exit 0 06:12:28 INFO - Browser initialized. 06:12:28 INFO - Running cycle 1/1 for kraken test... 06:12:28 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/T/tmpZD7ACR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:40 INFO - PROCESS | 1652 | RSS: Main: 233172992 06:12:40 INFO - PROCESS | 1652 | 06:12:43 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:44 INFO - PROCESS | 1652 | RSS: Main: 285589504 06:12:44 INFO - PROCESS | 1652 | 06:12:47 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 06:12:47 INFO - PROCESS | 1652 | RSS: Main: 287248384 06:12:47 INFO - PROCESS | 1652 | 06:12:51 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 06:12:51 INFO - PROCESS | 1652 | RSS: Main: 377810944 06:12:51 INFO - PROCESS | 1652 | 06:12:53 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 06:12:54 INFO - PROCESS | 1652 | RSS: Main: 280293376 06:12:54 INFO - PROCESS | 1652 | 06:12:56 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:12:57 INFO - PROCESS | 1652 | RSS: Main: 282173440 06:12:57 INFO - PROCESS | 1652 | 06:13:00 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:00 INFO - PROCESS | 1652 | RSS: Main: 325689344 06:13:00 INFO - PROCESS | 1652 | 06:13:03 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:04 INFO - PROCESS | 1652 | RSS: Main: 328265728 06:13:04 INFO - PROCESS | 1652 | 06:13:07 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 06:13:08 INFO - PROCESS | 1652 | RSS: Main: 327389184 06:13:08 INFO - PROCESS | 1652 | 06:13:09 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:10 INFO - PROCESS | 1652 | RSS: Main: 302231552 06:13:10 INFO - PROCESS | 1652 | 06:13:12 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:13 INFO - PROCESS | 1652 | RSS: Main: 306348032 06:13:13 INFO - PROCESS | 1652 | 06:13:15 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:15 INFO - PROCESS | 1652 | RSS: Main: 308580352 06:13:15 INFO - PROCESS | 1652 | 06:13:18 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:19 INFO - PROCESS | 1652 | RSS: Main: 326574080 06:13:19 INFO - PROCESS | 1652 | 06:13:22 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:23 INFO - PROCESS | 1652 | RSS: Main: 320778240 06:13:23 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 06:13:25 INFO - PROCESS | 1652 | RSS: Main: 365137920 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | __start_tp_report 06:13:25 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 06:13:25 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 06:13:25 INFO - PROCESS | 1652 | |i|pagename|runs| 06:13:25 INFO - PROCESS | 1652 | |0;ai-astar;114;116;119;166;158;115;114;116;116;115 06:13:25 INFO - PROCESS | 1652 | |1;audio-beat-detection;139;110;111;147;132;131;111;108;131;106 06:13:25 INFO - PROCESS | 1652 | |2;audio-dft;185;184;183;183;181;184;186;185;187;184 06:13:25 INFO - PROCESS | 1652 | |3;audio-fft;81;61;62;90;61;61;59;59;80;60 06:13:25 INFO - PROCESS | 1652 | |4;audio-oscillator;90;71;89;70;69;69;86;69;68;82 06:13:25 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;87;85;86;87;87;86;85;86;88;87 06:13:25 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;94;94;93;94;95;94;94;108;103 06:13:25 INFO - PROCESS | 1652 | |7;imaging-desaturate;85;85;86;83;105;128;135;84;86;84 06:13:25 INFO - PROCESS | 1652 | |8;json-parse-financial;63;62;61;62;63;62;64;65;64;63 06:13:25 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;54;57;71;62;60;58;57;58;58;59 06:13:25 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;87;87;88;88;87;86;86;86;84;86 06:13:25 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;139;132;162;148;146;140;138;140;195;180 06:13:25 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;172;172;171;170;171;171;172;169;173;171 06:13:25 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;77;83;82;83;69;67;65;73;78;79 06:13:25 INFO - PROCESS | 1652 | __end_tp_report 06:13:25 INFO - PROCESS | 1652 | __start_cc_report 06:13:25 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2123 06:13:25 INFO - PROCESS | 1652 | __end_cc_report 06:13:25 INFO - PROCESS | 1652 | __startTimestamp1489068805302__endTimestamp 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | ------- Summary: start ------- 06:13:25 INFO - PROCESS | 1652 | Number of tests: 14 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:124.90 Median:116.00 stddev:19.69 (17.0%) stddev-sans-first:20.49 06:13:25 INFO - PROCESS | 1652 | Values: 114.0 116.0 119.0 166.0 158.0 115.0 114.0 116.0 116.0 115.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:131.00 stddev:14.95 (11.4%) stddev-sans-first:14.63 06:13:25 INFO - PROCESS | 1652 | Values: 139.0 110.0 111.0 147.0 132.0 131.0 111.0 108.0 131.0 106.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:1.69 (0.9%) stddev-sans-first:1.76 06:13:25 INFO - PROCESS | 1652 | Values: 185.0 184.0 183.0 183.0 181.0 184.0 186.0 185.0 187.0 184.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:67.40 Median:61.50 stddev:11.56 (18.8%) stddev-sans-first:11.16 06:13:25 INFO - PROCESS | 1652 | Values: 81.0 61.0 62.0 90.0 61.0 61.0 59.0 59.0 80.0 60.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:76.30 Median:76.50 stddev:9.26 (12.1%) stddev-sans-first:8.39 06:13:25 INFO - PROCESS | 1652 | Values: 90.0 71.0 89.0 70.0 69.0 69.0 86.0 69.0 68.0 82.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:87.00 stddev:0.97 (1.1%) stddev-sans-first:1.00 06:13:25 INFO - PROCESS | 1652 | Values: 87.0 85.0 86.0 87.0 87.0 86.0 85.0 86.0 88.0 87.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:94.00 stddev:5.01 (5.3%) stddev-sans-first:5.25 06:13:25 INFO - PROCESS | 1652 | Values: 94.0 94.0 94.0 93.0 94.0 95.0 94.0 94.0 108.0 103.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:84.50 stddev:19.79 (23.4%) stddev-sans-first:20.58 06:13:25 INFO - PROCESS | 1652 | Values: 85.0 85.0 86.0 83.0 105.0 128.0 135.0 84.0 86.0 84.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:63.00 stddev:1.20 (1.9%) stddev-sans-first:1.27 06:13:25 INFO - PROCESS | 1652 | Values: 63.0 62.0 61.0 62.0 63.0 62.0 64.0 65.0 64.0 63.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:58.50 stddev:4.58 (7.8%) stddev-sans-first:4.42 06:13:25 INFO - PROCESS | 1652 | Values: 54.0 57.0 71.0 62.0 60.0 58.0 57.0 58.0 58.0 59.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:87.00 stddev:1.18 (1.4%) stddev-sans-first:1.24 06:13:25 INFO - PROCESS | 1652 | Values: 87.0 87.0 88.0 88.0 87.0 86.0 86.0 86.0 84.0 86.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:152.00 Median:147.00 stddev:20.65 (14.0%) stddev-sans-first:21.36 06:13:25 INFO - PROCESS | 1652 | Values: 139.0 132.0 162.0 148.0 146.0 140.0 138.0 140.0 195.0 180.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.20 Median:171.50 stddev:1.14 (0.7%) stddev-sans-first:1.17 06:13:25 INFO - PROCESS | 1652 | Values: 172.0 172.0 171.0 170.0 171.0 171.0 172.0 169.0 173.0 171.0 06:13:25 INFO - PROCESS | 1652 | 06:13:25 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.60 Median:78.50 stddev:6.72 (8.6%) stddev-sans-first:7.11 06:13:25 INFO - PROCESS | 1652 | Values: 77.0 83.0 82.0 83.0 69.0 67.0 65.0 73.0 78.0 79.0 06:13:25 INFO - PROCESS | 1652 | -------- Summary: end -------- 06:13:25 INFO - PROCESS | 1652 | 06:13:26 INFO - TEST-INFO | 1652: exit 0 06:13:26 INFO - TEST-OK | kraken | took 60976ms 06:13:26 INFO - SUITE-END | took 1183s 06:13:26 INFO - Completed test suite (00:19:44) 06:13:26 INFO - javascript benchmark 06:13:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7554.954152173821, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3249.2039450334655, 3374.4938259261116, 3379.864805407784, 3385.0691059958517, 3392.457206846905, 5657.038303488406, 5756.107803290497, 5854.0, 5947.553933454992, 6001.429864162903, 5787.971060144693, 5854.414558544144, 5900.586958912878, 5905.0847118696565, 5954.761809527614, 5182.844514664566, 5235.685858848462, 5249.1338929076655, 5259.579233661298, 5270.5520030797425, 5379.5696344292555, 5395.05586522357, 5402.432744561824, 5421.159720243369, 5452.40023597404, 5176.870578235536, 5216.2958000669805, 5233.842984710464, 5309.787608495636, 5349.7057661828585, 5219.634625576211, 5228.633995620308, 5250.868728281824, 5253.684778913277, 5255.237990491396, 5154.613403994716, 5194.4026436959475, 5206.401263854667, 5231.0, 5247.2653828464045, 5754.395788442237, 5759.510441612468, 5761.452661997104, 5773.826785196451, 5779.9422005779825, 6212.9068063979075, 6216.222972128484, 6220.129181914535, 6227.190465239535, 6231.096491008823, 6132.6013809102715, 6193.194884665009, 6222.844428889269, 6223.25320961483, 6239.812805615838, 5898.793542226002, 5902.380250073767, 5925.022371308729, 5959.880802383928, 5997.370276121032, 6385.8722825544155, 6426.710798014101, 6428.164338636041, 6428.389303016206, 6443.162388889508, 6100.115483254903, 6126.895025200522, 6171.47542458896, 6259.4679452246155, 6261.436470717657, 6207.96896015517, 6217.533684973645, 6222.066689996536, 6230.065490176419, 6230.750769969241, 6189.226346706661, 6191.628502289877, 6206.503479721611, 6207.379262073757, 6207.596506227081, 5586.581006424534, 6178.0, 6194.225721784777, 6200.286966998763, 6213.068039793977, 4355.5208927018, 4901.779419926112, 5000.000000000015, 5006.549410553068, 5009.7495125243595, 4414.823407063745, 4414.977925110354, 4416.205083085011, 4439.955600443955, 4529.796159172845, 5695.5443564514735, 5824.854378640568, 5961.791337303173, 5964.343922168558, 6033.939660603338, 6228.069737610555, 6271.43557079865, 6271.686415679198, 6272.2159730033745, 6286.371362863677, 5733.283339582552, 5764.74058667361, 5961.850953726105, 5976.581639285208, 5985.311689155803, 5488.451154884479, 5496.450354964471, 5496.983058134178, 5497.202905578669, 5508.20131080999, 5365.409804921455, 6239.75040998355, 6290.779822706183, 6300.621962682254, 6308.400701933309, 3650.6349365064343, 5378.462153784591, 6247.3440288769025, 6301.117843501822, 6318.6840657965995, 6482.54622176462, 6498.480121590356, 6514.73941042353, 6516.315786842503, 6527.412532872065, 6148.354422785543, 6175.752969881154, 6222.657753823583, 6285.057241413824, 6290.842728931813, 6257.906131407942, 6263.96868015657, 6268.059791031199, 6270.6864656766065, 6286.811395658137, 6111.052786818051, 6140.9078863816185, 6148.0, 6155.292141403616, 6160.921838678124, 6140.903050468011, 6166.969165154145, 6186.752529898754, 6234.438900498977, 6258.561900667091, 6174.567780255339, 6179.62922224668, 6181.412765787243, 6185.659788711664, 6205.906911396423, 6236.6258024518675, 6262.311145774052, 6262.499000079892, 6275.246970363585, 6276.623402595859, 5948.821535353946, 5991.520678345809, 6093.9390606093375, 6105.572609917263, 6177.6911154443], "value": 5746.53068692233, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.9634018299084, 759.2445516710874, 796.2952786783696, 876.3120950054205, 877.3156937588675, 27597.448051038966, 28540.429191416184, 38694.41958370623, 38887.61112388875, 41197.0, 38963.610363896354, 39190.0, 39349.21301573967, 39358.0, 39533.40699889497, 8972.685955991541, 9138.0, 9140.954295228514, 9151.0, 9155.0, 7284.417246620258, 7454.1055073391, 7521.172671006185, 7523.285287897668, 7532.472726909118, 10706.464676766169, 10896.836547451794, 11016.228863979524, 11054.060404865597, 11062.612808551703, 10787.78424431511, 10848.0, 10854.837177442385, 10887.455627218687, 10901.454927253684, 7157.498975071747, 10562.630307939262, 10629.84055239172, 10647.787044259072, 10649.733756656067, 27619.309517262027, 27809.026684066164, 27856.721432785816, 37932.620673793186, 38470.23059538793, 3853.2871418787613, 3854.4411060396087, 3863.4357300852107, 3870.8645197417954, 3917.490726205575, 27737.58393624097, 27846.886124554992, 27985.440291194063, 28173.85913070442, 28755.13734587966, 2737.8494182819936, 2948.0418863869113, 3053.603031605899, 3100.302431952815, 3102.844857757103, 347066.0, 351881.0, 353467.2326638376, 354150.0, 355381.0, 41895.9526011846, 51510.48489515132, 51560.484395156316, 51570.96858062818, 51695.741521292155, 44541.777291113336, 44659.77670111629, 44803.551964479935, 49235.75382123067, 49242.26136607954, 14787.0, 14859.702805944036, 14881.479148229977, 14881.949200413888, 14886.553403397915, 12079.57721479744, 12250.938745306217, 12281.324527150913, 12287.017038636888, 12315.384230788424, 12925.095243333064, 12925.482980680668, 12960.0, 13021.414036368385, 13079.869201307865, 4474.26174681174, 5264.499872512105, 5312.946870531323, 5327.147656374961, 5339.065663508871, 1091.6179337231906, 1097.2757979733337, 1101.680512651322, 1122.2144498850837, 1174.48322737995, 22540.774592253867, 26292.0, 26688.866555667486, 26781.062662806708, 27000.919963201253, 1175.2243519277406, 1193.4689063366718, 1202.897753690946, 1220.7558488302375, 1267.1700036476122, 12974.675633109058, 13728.0, 13879.838781552997, 14028.368723407268, 14053.0, 368752.0, 427123.0, 428209.0, 428612.0, 428755.0, 55301.72349138309, 55366.89266214653, 55418.44581554214, 55425.0, 55442.89114217693, 1382.8962827787957, 1431.7709166533514, 1435.5980325508874, 1437.583100900727, 1440.3662388549005, 17747.645047099242, 25631.359216019748, 25819.870900645376, 25861.0, 25935.0, 45496.54503455055, 45513.0, 45609.771951140036, 45630.31554526751, 45709.62871113872, 431104.0, 432680.0, 433069.0, 433342.0, 433583.0, 27226.72773272242, 28995.56506652444, 33551.32897342088, 33655.495167572015, 35032.0, 42819.357709633754, 43826.0, 43904.34143487914, 44152.0, 44417.777911110235, 27992.0, 32915.50626740553, 34176.974690759314, 35667.46498802572, 36852.0, 30700.46497675152, 34441.277936103594, 34826.0, 35244.29511409809, 36513.0, 36031.459528107625, 36073.27853442864, 36129.0, 36160.91517254487, 37099.443508346856, 31036.379272414877, 32114.299913032675, 32517.349653006335, 32533.34933301368, 32607.836960815042, 24168.274951751475, 24328.635070474313, 24360.120821906865, 24467.38831529226, 24497.510049798548], "value": 18358.971960823663, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.4751913637885, 396.6192455242967, 411.5411316382235, 416.79368712487326, 442.11576846307383, 12937.805932911002, 19718.30985915493, 20397.796022039776, 21942.0, 22437.663435048486, 16265.349386024545, 20861.68707469389, 21531.0, 22293.2197373092, 22557.872106394698, 5769.624974376673, 6400.103985442053, 6690.431313338372, 6759.864802703943, 6771.221309549391, 6448.613083214998, 7594.620268986529, 7597.430192735539, 7603.695852165907, 7604.505707129047, 7413.147488038863, 7474.439417043716, 7487.0, 7564.962175189116, 7606.809829754273, 7411.740589079356, 7444.292792184734, 7493.925060749404, 7505.362044226247, 7719.575423351714, 7358.77923662291, 7598.810029749246, 7635.580043097628, 7642.121156067068, 7647.235276472308, 27592.586111208348, 27772.861135694395, 28457.430851383062, 28461.00386486463, 28549.714502854913, 2887.7978541502102, 2898.2464559214545, 2900.3474218300926, 2944.322805754667, 3221.742260619168, 15773.921130394388, 16476.588085297964, 16833.91583042089, 16865.662686746196, 17755.02347370894, 2001.0695026812457, 2038.2458490358515, 2044.7444069491314, 2049.9795002049937, 2055.80469855365, 154803.0, 159728.0, 160976.0, 161419.1929040359, 165997.08035035752, 15551.377944882079, 16567.337306507605, 21805.563888722136, 21881.67177492339, 21993.120275188812, 28770.993015244785, 34337.48493772595, 34717.78487752967, 34751.826240868635, 36215.27569448649, 8575.656973720981, 9025.864612030824, 10346.0, 10650.254482186327, 10715.732106697238, 8446.915530844735, 8576.699815506552, 8706.347023973101, 8769.605367758466, 8815.66384908, 9192.172704456498, 10425.218108641882, 10570.207234457446, 10634.30876992993, 10787.137029037658, 4208.431861698631, 4258.850940217078, 4282.207791558571, 4292.570742925683, 4318.5033721121845, 857.7341024282492, 862.9515139105891, 923.5013092929743, 924.2882980105281, 941.7928055827844, 21775.346739597837, 23359.065637374315, 23386.673465408952, 23408.414789630056, 23500.647490287658, 897.869808877709, 903.4398672822892, 916.3631276262934, 917.9678711245074, 918.3250311021394, 11777.941110294565, 11907.34509601963, 12239.449224784907, 12251.693707657201, 12257.816132758016, 695519.0, 697378.0, 701060.0, 719903.0, 744205.0, 149834.00663973318, 151875.0, 152729.0, 154560.0, 157911.0, 1165.9533618655328, 1196.7068068323317, 1227.5151315230255, 1231.359692959656, 1235.4440501774238, 19888.801111988694, 19900.50248743793, 20277.2902948402, 20284.0, 20414.877181755146, 56641.716791415776, 59655.81265347688, 60509.39490605213, 61848.9999999982, 62647.37352626416, 87312.56343718241, 89394.65908011515, 89834.55082724807, 89909.0, 91011.63482547899, 10060.39637621745, 10113.5448904798, 12175.573854915036, 12230.266184028987, 12296.139270251355, 13342.266175360448, 13857.584272471842, 13876.722465550834, 14243.572692818818, 14288.928555357572, 10160.0, 11702.414879255834, 11964.401779910795, 12013.0, 12036.217645852992, 11459.713507162387, 11494.425278735862, 11846.052315814886, 11894.397760494072, 11940.880591193976, 11694.532218711156, 11720.765584688088, 11991.700207494534, 12020.579279725167, 12073.818892716792, 11849.170558060852, 11928.0, 12216.75566488683, 12261.632151035483, 12280.263184208976, 11501.252418592765, 11549.133814963743, 11934.820977685515, 11948.522059117886, 11995.700107497034], "value": 11860.996235028422, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1563.2105786577777, 1573.6931298396803, 1580.2572790788329, 1594.6252630631807, 1599.1604407685963, 10465.31975421598, 11066.778664426707, 11074.612388566402, 11075.224734268615, 11077.778444431116, 10578.047975682188, 10987.285826421277, 11190.888091119086, 11193.328400295988, 11201.495932683029, 2325.2559181062065, 2371.1937941100023, 2371.9644205336936, 2372.1578839511985, 2373.394784330002, 2302.654601809725, 2331.80179684727, 2334.9182778602753, 2340.508493216427, 2345.4839935214227, 2306.8581052379095, 2322.1756276521846, 2324.337563794319, 2333.7666233376613, 2334.743178250391, 2257.266388423769, 2282.8287878409187, 2286.3826766772963, 2286.7484576696465, 2291.5531471363092, 2248.033345661365, 2303.3761198355287, 2306.411864974438, 2306.5848147333472, 2308.699869017034, 9562.091601297865, 10971.890281097167, 11000.284981476178, 11110.44447777616, 11169.385683787388, 5501.174823776426, 5675.318961724578, 5676.091825307931, 5683.090705487102, 5683.090705487143, 3292.884749033772, 3402.3705614461405, 3583.380785406732, 3585.995921142084, 3600.5859326177565, 1101.895319944604, 1103.382106020631, 1104.276698762312, 1119.7312644965232, 1225.4118023348842, 14973.401063957428, 15016.849831501655, 15081.54755357341, 15107.848921510864, 15127.621809454742, 3959.247742928834, 4266.978665106654, 4497.100579884036, 4581.0, 4586.334981427741, 9648.903510964941, 11173.385463799406, 11223.494942727597, 11235.325880447199, 11262.943685281522, 5512.80705175317, 5513.448655134454, 5513.61404701667, 5521.723913804374, 5538.86152846174, 4873.634477414208, 4890.510948905081, 5072.695638261716, 5084.3644544431945, 5210.843674689765, 3593.13764696471, 3666.4866918631415, 3678.5953545110015, 3723.404255319136, 3733.9439908401396, 1000.7748256642197, 1002.1231422505308, 1010.3230835340339, 1017.1151098544166, 1020.7958408318366, 877.6401675313218, 911.4303560274828, 918.9908100919039, 943.9993606776701, 950.9524523773783, 6386.137871387304, 6460.418562329319, 6476.125723027425, 6503.772367967098, 6527.834598920354, 900.2213085680839, 925.153484561632, 949.8955114937352, 983.6163896080534, 997.6458357283205, 3804.239152169577, 3879.6702280305926, 3931.8623848165175, 4043.3732771420478, 4050.594940505926, 12885.291308977909, 13190.406431710597, 13388.0, 13435.059545831893, 13452.394642241123, 11787.174897757246, 13276.26980516081, 13295.401706923212, 13314.800277995837, 13315.66710832237, 7354.264573542603, 8495.447795893371, 8567.858035491126, 8671.566421679017, 8832.5583720815, 5516.641418307797, 6376.808695739135, 6505.316941721051, 6597.3072827352435, 6685.6322902240845, 11174.832377514507, 11807.291562506278, 11856.881431185579, 11857.940710296394, 11888.34614096233, 11849.940750296193, 11975.880241197476, 11975.940120299343, 12168.817467738168, 12352.938235308766, 8202.302804261704, 8236.794080147805, 8311.6675332986, 8316.5425901576, 8333.458325208841, 7981.0, 9584.856227156737, 10014.94992525062, 10041.0, 10126.24053196028, 8841.867371989554, 8951.865722014045, 9006.909930900869, 9161.908380916373, 9169.128932751379, 8696.956515217636, 8813.383063185516, 8815.647374104963, 8922.286217102746, 9054.864177037218, 7467.962660186664, 7597.392208623186, 7719.4210434218785, 7721.266479684421, 7736.613169341623, 5605.159226116115, 5778.94221057784, 5782.479576838105, 5855.560832937462, 5906.557008224315, 5759.0, 5882.852928676646, 5900.734466949083, 5909.349971503218, 5957.374475680164], "value": 4959.957252816037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.1442717816967, 377.71482530689326, 382.45118255303623, 389.1341764573823, 391.71209161266466, 4434.935615452292, 4528.479224889139, 4823.204171311734, 4848.878778030551, 4861.0, 4191.910103373122, 4501.684882058257, 4613.354130421743, 4757.571818536331, 4813.181759100952, 3630.8547658093644, 3841.5390153181656, 3967.6032396760384, 4042.373432118019, 4051.493563304587, 3483.4078206704794, 3996.560378358393, 4015.5382131054866, 4046.5751096134923, 4063.5936406359424, 3634.6547078027547, 4062.4718786557855, 4074.633283004529, 4102.897427564305, 4124.237016152021, 3300.785448945835, 3442.862285508589, 3464.5149679044953, 3774.6602805747475, 4057.939130913009, 3512.631173726773, 3606.855725770966, 3733.4399840023943, 3738.12154143776, 3766.3785475396526, 3858.6913046956174, 4627.676062675614, 4678.1813182692895, 4729.62163026957, 4802.639802014863, 4341.696081274312, 4660.277656963176, 4729.739864307462, 4735.455422626374, 4735.786889589976, 5099.46455622158, 5163.741812909339, 5176.870578235536, 5199.272101905736, 5223.503767142115, 3754.418065199871, 3855.8650447234213, 4129.648979836717, 4158.875233742992, 4165.625093741578, 4512.796924138389, 4516.36770852081, 4877.34155888954, 5154.793808247666, 5275.956597941752, 4077.1234184649848, 4202.306619407764, 4204.201201771653, 4228.8010234677795, 4242.66058715302, 3820.178661587772, 3869.2481619574023, 4093.85671501496, 4275.957240427618, 4333.306670932636, 4234.38601402801, 4339.674524410681, 4446.911061778811, 4640.419947506562, 4689.6717229793585, 4196.874093777131, 4898.4121905371585, 4951.653384263067, 5051.949480505222, 5138.922916156261, 1244.6433387607551, 1437.1448987852211, 1450.840407555168, 1455.4542046732474, 1462.1722846441949, 938.1931538876561, 1082.0856376361962, 1106.1482658353184, 1117.591834288802, 1126.3523474002482, 4460.576245256695, 4738.384010078667, 4766.737829419415, 4828.46886842447, 5059.316992206005, 4331.025519258142, 4954.950450495521, 5194.610404219623, 5322.973385133049, 5328.813491527778, 4096.631303182728, 4541.8183272669385, 4750.0, 4809.687370320918, 4824.035192961422, 2545.656336394563, 2619.7642212200612, 2621.934451638686, 2776.0428897627125, 2786.5541513357766, 5033.748312584356, 5219.739013049332, 5234.685918844882, 5482.753276102585, 5512.2558454608115, 4506.81972721094, 4844.588210002189, 4954.677945933575, 5464.3442786865035, 5515.944840551623, 4918.9508104919205, 5426.0, 5456.536194423518, 5469.808556700496, 5497.670139791625, 4653.022865198346, 4719.882002949954, 4876.0, 5113.360829896263, 5187.58499320061, 4248.745075295492, 4873.390826146731, 5116.316252298339, 5202.843914682566, 5288.788448462018, 4636.675432719677, 5005.824796132118, 5295.417504074626, 5520.503154716095, 5524.917126243029, 3750.943735844019, 3765.868194613285, 4244.596763307481, 4251.766152861499, 4277.871663850089, 4636.536346365471, 4921.040397122527, 5063.620228482805, 5305.31030965972, 5346.572274218131, 4746.315058154443, 5085.720285384339, 5112.872178195575, 5114.820981265638, 5257.8159764408065, 4350.456192975878, 4631.93052104212, 4953.578945789648, 5150.40770311419, 5159.716215608178, 4305.256371169681, 4688.990912769669, 4848.981713839992, 4992.600591952708, 4995.650304478797, 4539.636829053734, 4624.0, 4798.448178459522, 4936.7910857942625, 5128.435872053997, 4542.18240716661, 4564.448087650215, 4677.415323084614, 4679.742614156254, 5064.569511591409], "value": 3921.79332853236, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.6612825843595, 709.3927379276379, 729.3290173040799, 743.5427212264456, 757.481125429081, 14898.404063837446, 15416.922915385407, 15818.288177032033, 15831.0, 16172.19139043046, 14345.713085738278, 14645.926770366133, 14818.925905370485, 14901.92549037256, 14932.402703891832, 911.7173676160412, 950.8526178442353, 952.4570994533119, 954.4273435938451, 958.9520523973808, 929.8372784762673, 945.9574319155655, 948.8956214816365, 949.0130264524886, 981.8232718110737, 1026.2046913641911, 1031.8555402243692, 1033.7570670892335, 1034.5913364221128, 1035.373598972622, 1024.774549599087, 1025.2208321675505, 1026.1893104447477, 1028.0695970147028, 1031.3244824639874, 730.2733779889045, 731.579341878422, 731.6378392695597, 754.7660225330166, 764.3503022430945, 15671.294791734399, 15856.445024424205, 16105.194740263058, 16129.516114516584, 16221.513354599381, 12386.876131238663, 14297.571072867831, 14353.78469322961, 14561.708765824624, 14670.853291467161, 9632.518374081268, 11490.425478726114, 11577.710557236052, 11826.403435536178, 12157.93921030398, 3683.318586061587, 3728.4966529518438, 3767.472553842437, 3898.941515877264, 3899.4345819856244, 106042.40936385961, 108342.0, 109863.0, 110044.4497777514, 110109.89890101156, 11218.508792075636, 11315.773684526428, 11375.772484550429, 11834.892614300135, 11884.524619015316, 24823.882925268405, 24853.378665533146, 25051.498970020497, 25073.62389564158, 25094.372640683763, 7614.6954121835615, 7720.884186737204, 7812.140664526897, 7827.491213071246, 7873.724419645285, 3729.5524537055726, 4171.124063946544, 4228.70399072062, 4253.787310634456, 4350.847720329773, 3453.913652158716, 3516.7538272321203, 3517.7889326640484, 3526.0303416560137, 3570.2145527983803, 634.2895956528718, 635.9427651511386, 642.5919541091347, 650.5771248688296, 651.7555916531301, 619.8884200843892, 641.6535071061575, 651.4592887903029, 671.3655595462242, 688.9379955804002, 10043.799124017478, 10045.921648991087, 10098.899011009942, 10205.183585313158, 10331.483425828828, 658.8649326887977, 670.963097029668, 680.8638272345452, 689.1454596300551, 693.4798900824381, 4845.53967373099, 4886.53577910098, 4996.875078123076, 4997.7251251180805, 5015.097282489187, 105364.0, 105546.0, 105557.0, 106971.0, 107219.46390267999, 48397.758011210426, 60086.39913600896, 75273.0, 81582.18417815864, 89726.10273897178, 66264.6686766563, 69040.0, 70738.29261707523, 79292.4141517155, 83398.0, 9334.813303734023, 10611.681649550526, 10868.641419822523, 10869.29349592274, 11101.94449027782, 45165.838391312296, 45369.0, 49431.25853112278, 50143.49856501534, 50997.7450112747, 58493.0, 66393.66803165953, 69205.2698682537, 69488.0, 70248.6487567559, 13529.661758456117, 13747.656308592364, 13919.373628186553, 14002.36989335462, 14038.438462461387, 14107.506237281646, 14613.780793288322, 14627.19550424737, 14904.329305181509, 15147.621309467351, 13291.460033193975, 13442.798358024442, 13783.586492405244, 13802.240876751875, 14153.08004979673, 13677.24775137377, 13746.737717444013, 13880.236586987812, 14269.001169918007, 14289.268865576883, 13130.570844393818, 13387.397567109698, 13395.196288222738, 13457.906768710785, 14323.14061156334, 10298.794024119326, 10639.308444951053, 10867.84882537246, 11048.447577621248, 11073.446327683423, 7370.651315723749, 7717.498362606412, 10752.946235268773, 11278.774424511628, 11296.6046188383], "value": 7638.481389960934, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1461.8, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 119.0, 166.0, 158.0, 115.0, 114.0, 116.0, 116.0, 115.0], "value": 124.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 110.0, 111.0, 147.0, 132.0, 131.0, 111.0, 108.0, 131.0, 106.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 183.0, 183.0, 181.0, 184.0, 186.0, 185.0, 187.0, 184.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 62.0, 90.0, 61.0, 61.0, 59.0, 59.0, 80.0, 60.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 71.0, 89.0, 70.0, 69.0, 69.0, 86.0, 69.0, 68.0, 82.0], "value": 76.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 86.0, 87.0, 87.0, 86.0, 85.0, 86.0, 88.0, 87.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 95.0, 94.0, 94.0, 108.0, 103.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 83.0, 105.0, 128.0, 135.0, 84.0, 86.0, 84.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 62.0, 63.0, 62.0, 64.0, 65.0, 64.0, 63.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 71.0, 62.0, 60.0, 58.0, 57.0, 58.0, 58.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 88.0, 88.0, 87.0, 86.0, 86.0, 86.0, 84.0, 86.0], "value": 86.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 132.0, 162.0, 148.0, 146.0, 140.0, 138.0, 140.0, 195.0, 180.0], "value": 152.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 171.0, 170.0, 171.0, 171.0, 172.0, 169.0, 173.0, 171.0], "value": 171.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 83.0, 82.0, 83.0, 69.0, 67.0, 65.0, 73.0, 78.0, 79.0], "value": 75.6, "unit": "score"}]}]} 06:13:26 INFO - Return code: 0 06:13:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:26 ERROR - # TBPL SUCCESS # 06:13:26 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:13:26 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:13:26 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:13:26 INFO - 2017-03-09 06:13:26.592 screenresolution[1656:10087] starting screenresolution argv=screenresolution get 06:13:26 INFO - 2017-03-09 06:13:26.595 screenresolution[1656:10087] Display 0: 1600x1200x32@60 06:13:26 INFO - 2017-03-09 06:13:26.602 screenresolution[1657:10090] starting screenresolution argv=screenresolution list 06:13:26 INFO - Available Modes on Display 0 06:13:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:13:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:13:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:13:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:13:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:13:26 INFO - Intel Iris: 06:13:26 INFO - Chipset Model: Intel Iris 06:13:26 INFO - Type: GPU 06:13:26 INFO - Bus: Built-In 06:13:26 INFO - VRAM (Dynamic, Max): 1536 MB 06:13:26 INFO - Vendor: Intel (0x8086) 06:13:26 INFO - Device ID: 0x0a2e 06:13:26 INFO - Revision ID: 0x0009 06:13:26 INFO - Displays: 06:13:26 INFO - Display: 06:13:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:13:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:13:26 INFO - Display Serial Number: 1600x1200 60 06:13:26 INFO - Main Display: Yes 06:13:26 INFO - Mirror: Off 06:13:26 INFO - Online: Yes 06:13:26 INFO - Rotation: Supported 06:13:26 INFO - Return code: 0 06:13:26 INFO - Running post-action listener: _resource_record_post_action 06:13:26 INFO - [mozharness: 2017-03-09 14:13:26.841919Z] Finished run-tests step (success) 06:13:26 INFO - Running post-run listener: _resource_record_post_run 06:13:26 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 38102016; Write bytes: 513416192; Read time: 243; Write time: 1600 06:13:26 INFO - TinderboxPrint: CPU usage
54.0% 06:13:26 INFO - TinderboxPrint: I/O read bytes / time
38,102,016 / 243 06:13:26 INFO - TinderboxPrint: I/O write bytes / time
513,416,192 / 1,600 06:13:26 INFO - TinderboxPrint: CPU idle
2,216.6 (46.0%) 06:13:26 INFO - TinderboxPrint: CPU system
962.6 (20.0%) 06:13:26 INFO - TinderboxPrint: CPU user
1,642.5 (34.1%) 06:13:26 INFO - TinderboxPrint: Swap in / out
247,894,016 / 0 06:13:26 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203336192; Write bytes: 203839488; Read time: 15616; Write time: 437 06:13:26 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 36275200; Write bytes: 298759168; Read time: 226; Write time: 1126 06:13:27 INFO - Running post-run listener: _upload_blobber_files 06:13:27 INFO - Blob upload gear active. 06:13:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:27 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 06:13:27 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'] 06:13:27 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 06:13:27 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:13:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:13:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:28 INFO - (blobuploader) - INFO - Done attempting. 06:13:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:13:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:13:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:29 INFO - (blobuploader) - INFO - Done attempting. 06:13:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:13:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:30 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:13:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:30 INFO - (blobuploader) - INFO - Done attempting. 06:13:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:33 INFO - (blobuploader) - INFO - Done attempting. 06:13:33 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:33 INFO - Return code: 0 06:13:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:33 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/595fadc1db055e784890fddbfeaadb267d466489e9f770c35792d36739942ba82dc825b8ce5b16cbae41ebffba15336d40394a6df372d1b1ff5614e672d12c53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25ad107a4502d7fcd6be0a3cc3bbda010c8e7e8f36796c811021a02b78ccad8430db43ef5d58a29d5c3f10c448010c9d1e236d3cd75a76273c164c0c2bdb3241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e092b43ec3e03a01c71b79f7c4d707654a0edd31c47e19d1e3c649bafa2d078c1768dfc0faeeeeff0151e3b3570dd93f2984e20ee077477a4f2d6a85cf93af", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10a38f85b677220d669f281a630364fb39c5afe8669661929628575bb414294987326a6c8e2683634a8dba147eb30086cad4650cb34233156eb4da5d804d2bf4"} 06:13:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:33 INFO - Contents: 06:13:33 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/595fadc1db055e784890fddbfeaadb267d466489e9f770c35792d36739942ba82dc825b8ce5b16cbae41ebffba15336d40394a6df372d1b1ff5614e672d12c53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25ad107a4502d7fcd6be0a3cc3bbda010c8e7e8f36796c811021a02b78ccad8430db43ef5d58a29d5c3f10c448010c9d1e236d3cd75a76273c164c0c2bdb3241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e092b43ec3e03a01c71b79f7c4d707654a0edd31c47e19d1e3c649bafa2d078c1768dfc0faeeeeff0151e3b3570dd93f2984e20ee077477a4f2d6a85cf93af", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10a38f85b677220d669f281a630364fb39c5afe8669661929628575bb414294987326a6c8e2683634a8dba147eb30086cad4650cb34233156eb4da5d804d2bf4"} 06:13:33 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:33 INFO - Copying logs to upload dir... 06:13:33 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1288.580806 ========= master_lag: 0.16 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-09 06:13:33.421772) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 06:13:33.425486) ========= 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.xs98sMBB3m/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.4aODVN5QI8/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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/595fadc1db055e784890fddbfeaadb267d466489e9f770c35792d36739942ba82dc825b8ce5b16cbae41ebffba15336d40394a6df372d1b1ff5614e672d12c53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25ad107a4502d7fcd6be0a3cc3bbda010c8e7e8f36796c811021a02b78ccad8430db43ef5d58a29d5c3f10c448010c9d1e236d3cd75a76273c164c0c2bdb3241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e092b43ec3e03a01c71b79f7c4d707654a0edd31c47e19d1e3c649bafa2d078c1768dfc0faeeeeff0151e3b3570dd93f2984e20ee077477a4f2d6a85cf93af", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10a38f85b677220d669f281a630364fb39c5afe8669661929628575bb414294987326a6c8e2683634a8dba147eb30086cad4650cb34233156eb4da5d804d2bf4"} build_url:https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011049 build_url: 'https://queue.taskcluster.net/v1/task/HodiXT-GSXqvSq42qHGX0A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/595fadc1db055e784890fddbfeaadb267d466489e9f770c35792d36739942ba82dc825b8ce5b16cbae41ebffba15336d40394a6df372d1b1ff5614e672d12c53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/25ad107a4502d7fcd6be0a3cc3bbda010c8e7e8f36796c811021a02b78ccad8430db43ef5d58a29d5c3f10c448010c9d1e236d3cd75a76273c164c0c2bdb3241", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e0e092b43ec3e03a01c71b79f7c4d707654a0edd31c47e19d1e3c649bafa2d078c1768dfc0faeeeeff0151e3b3570dd93f2984e20ee077477a4f2d6a85cf93af", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10a38f85b677220d669f281a630364fb39c5afe8669661929628575bb414294987326a6c8e2683634a8dba147eb30086cad4650cb34233156eb4da5d804d2bf4"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-09 06:13:33.462343) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 06:13:33.462903) ========= 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.xs98sMBB3m/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.4aODVN5QI8/Listeners TMPDIR=/var/folders/t7/_pz7xln100vdkv4w4jlh985400000w/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.005250 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-09 06:13:33.511888) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 06:13:33.512247) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-09 06:13:33.512564) ========= ========= Total master_lag: 0.30 =========