builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0124 starttime: 1485351934.75 results: success (0) buildid: 20170125043148 builduid: 3089c0e7fd2140eca123543cf1c78dd0 revision: 95df6209f125277b6db62402897dd125f4fda5ae ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:34.751110) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:34.751568) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:34.751841) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:34.778204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:34.778603) ========= 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.vebn4jyhBf/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.fuVqlEr41h/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-01-25 05:45:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 135M=0s 2017-01-25 05:45:34 (135 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.142122 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:34.942142) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:34.942470) ========= 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.vebn4jyhBf/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.fuVqlEr41h/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.029770 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:34.994545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 05:45:34.994898) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 95df6209f125277b6db62402897dd125f4fda5ae --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 95df6209f125277b6db62402897dd125f4fda5ae --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vebn4jyhBf/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.fuVqlEr41h/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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-01-25 05:45:35,100 truncating revision to first 12 chars 2017-01-25 05:45:35,100 Setting DEBUG logging. 2017-01-25 05:45:35,101 attempt 1/10 2017-01-25 05:45:35,101 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/95df6209f125?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-25 05:45:36,399 unpacking tar archive at: mozilla-central-95df6209f125/testing/mozharness/ program finished with exit code 0 elapsedTime=1.594240 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-25 05:45:36.612933) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:36.613290) ========= script_repo_revision: 95df6209f125277b6db62402897dd125f4fda5ae ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:36.613700) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:36.613968) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-25 05:45:36.634142) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-25 05:45:36.634503) ========= /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.vebn4jyhBf/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.fuVqlEr41h/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:45:36 INFO - MultiFileLogger online at 20170125 05:45:36 in /builds/slave/test 05:45:36 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:45:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:45:36 INFO - {'append_to_log': False, 05:45:36 INFO - 'base_work_dir': '/builds/slave/test', 05:45:36 INFO - 'blob_upload_branch': 'Firefox', 05:45:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:45:36 INFO - 'branch': 'Firefox', 05:45:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:45:36 INFO - 'config_files': ('talos/mac_config.py',), 05:45:36 INFO - 'default_actions': ('clobber', 05:45:36 INFO - 'read-buildbot-config', 05:45:36 INFO - 'download-and-extract', 05:45:36 INFO - 'populate-webroot', 05:45:36 INFO - 'create-virtualenv', 05:45:36 INFO - 'install', 05:45:36 INFO - 'run-tests'), 05:45:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:45:36 INFO - 'download_minidump_stackwalk': True, 05:45:36 INFO - 'download_symbols': 'ondemand', 05:45:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:45:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:45:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:45:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:45:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:45:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:45:36 INFO - 'installer_path': 'installer.exe', 05:45:36 INFO - 'log_level': 'info', 05:45:36 INFO - 'log_name': 'talos', 05:45:36 INFO - 'log_to_console': True, 05:45:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:45:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:45:36 INFO - 'opt_config_files': (), 05:45:36 INFO - 'pip_index': False, 05:45:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:36 INFO - 'cmd': ('bash', 05:45:36 INFO - '-c', 05:45:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:36 INFO - 'enabled': True, 05:45:36 INFO - 'halt_on_failure': False, 05:45:36 INFO - 'name': 'check_screen_resolution'},), 05:45:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:45:36 INFO - 'cmd': ('bash', 05:45:36 INFO - '-c', 05:45:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:45:36 INFO - 'enabled': True, 05:45:36 INFO - 'halt_on_failure': False, 05:45:36 INFO - 'name': 'check_screen_resolution'},), 05:45:36 INFO - 'run_cmd_checks_enabled': True, 05:45:36 INFO - 'sps_profile': False, 05:45:36 INFO - 'sps_profile_interval': 0, 05:45:36 INFO - 'suite': 'dromaeojs', 05:45:36 INFO - 'system_bits': '32', 05:45:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:45:36 INFO - 'title': 't-yosemite-r7-0124', 05:45:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:45:36 INFO - 'use_talos_json': True, 05:45:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:45:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:45:36 INFO - 'work_dir': 'build'} 05:45:36 INFO - [mozharness: 2017-01-25 13:45:36.853552Z] Running clobber step. 05:45:36 INFO - Running pre-action listener: _resource_record_pre_action 05:45:36 INFO - Running main action method: clobber 05:45:36 INFO - rmtree: /builds/slave/test/build 05:45:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:45:39 INFO - Running post-action listener: _resource_record_post_action 05:45:39 INFO - [mozharness: 2017-01-25 13:45:39.422744Z] Finished clobber step (success) 05:45:39 INFO - [mozharness: 2017-01-25 13:45:39.422909Z] Running read-buildbot-config step. 05:45:39 INFO - Running pre-action listener: _resource_record_pre_action 05:45:39 INFO - Running main action method: read_buildbot_config 05:45:39 INFO - Using buildbot properties: 05:45:39 INFO - { 05:45:39 INFO - "project": "", 05:45:39 INFO - "product": "firefox", 05:45:39 INFO - "script_repo_revision": "production", 05:45:39 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:45:39 INFO - "repository": "", 05:45:39 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:45:39 INFO - "buildid": "20170125043148", 05:45:39 INFO - "pgo_build": "False", 05:45:39 INFO - "basedir": "/builds/slave/test", 05:45:39 INFO - "buildnumber": 71, 05:45:39 INFO - "slavename": "t-yosemite-r7-0124", 05:45:39 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 05:45:39 INFO - "platform": "yosemite_r7", 05:45:39 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:45:39 INFO - "branch": "mozilla-central", 05:45:39 INFO - "repo_path": "mozilla-central", 05:45:39 INFO - "revision": "95df6209f125277b6db62402897dd125f4fda5ae", 05:45:39 INFO - "stage_platform": "macosx64", 05:45:39 INFO - "builduid": "3089c0e7fd2140eca123543cf1c78dd0", 05:45:39 INFO - "slavebuilddir": "test" 05:45:39 INFO - } 05:45:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 05:45:39 INFO - Running post-action listener: _resource_record_post_action 05:45:39 INFO - [mozharness: 2017-01-25 13:45:39.426178Z] Finished read-buildbot-config step (success) 05:45:39 INFO - [mozharness: 2017-01-25 13:45:39.426309Z] Running download-and-extract step. 05:45:39 INFO - Running pre-action listener: _resource_record_pre_action 05:45:39 INFO - Running main action method: download_and_extract 05:45:39 INFO - mkdir: /builds/slave/test/build/tests 05:45:39 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:45:39 INFO - trying https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 05:45:39 INFO - Downloading https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:45:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 05:45:40 INFO - Downloaded 1199 bytes. 05:45:40 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:45:40 INFO - Using the following test package requirements: 05:45:40 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:45:40 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:45:40 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 05:45:40 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:45:40 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 05:45:40 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:45:40 INFO - u'jsshell-mac.zip'], 05:45:40 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:45:40 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 05:45:40 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:45:40 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:45:40 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 05:45:40 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:45:40 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 05:45:40 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:45:40 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 05:45:40 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:45:40 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 05:45:40 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:45:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:45:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:45:40 INFO - Fetch https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:45:41 INFO - Expected file size: 16351775 05:45:41 INFO - Obtained file size: 16351775 05:45:48 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:45:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:45:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:45:48 INFO - Fetch https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:45:49 INFO - Expected file size: 16351775 05:45:49 INFO - Obtained file size: 16351775 05:45:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 05:45:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:45:55 INFO - Fetch https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 05:45:56 INFO - Expected file size: 14403431 05:45:56 INFO - Obtained file size: 14403431 05:45: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:45:56 INFO - trying https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:45:56 INFO - Downloading https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 05:45:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 05:45:58 INFO - Downloaded 69881230 bytes. 05:45:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:45:58 INFO - mkdir: /builds/slave/test/properties 05:45:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:45:58 INFO - Writing to file /builds/slave/test/properties/build_url 05:45:58 INFO - Contents: 05:45:58 INFO - build_url:https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:45:59 INFO - Running post-action listener: _resource_record_post_action 05:45:59 INFO - Running post-action listener: set_extra_try_arguments 05:45:59 INFO - [mozharness: 2017-01-25 13:45:59.742638Z] Finished download-and-extract step (success) 05:45:59 INFO - [mozharness: 2017-01-25 13:45:59.742762Z] Running populate-webroot step. 05:45:59 INFO - Running pre-action listener: _resource_record_pre_action 05:45:59 INFO - Running main action method: populate_webroot 05:45:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:45:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:45:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:45:59 INFO - '--tppagecycles', 05:45:59 INFO - '7'], 05:45:59 INFO - 'tests': ['tsvgm']}}, 05:45:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:45:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:45:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:45:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:45:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:45:59 INFO - 'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:45:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:45:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:45:59 INFO - 'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['damp', 'tps']}, 05:45:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:45:59 INFO - 'tests': ['damp', 'tps']}, 05:45:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['dromaeo_dom']}, 05:45:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:45:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['basic_compositor_video']}, 05:45:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:45:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['a11yr', 05:45:59 INFO - 'ts_paint', 05:45:59 INFO - 'tpaint', 05:45:59 INFO - 'sessionrestore', 05:45:59 INFO - 'sessionrestore_no_auto_restore', 05:45:59 INFO - 'tabpaint']}, 05:45:59 INFO - 'other-e10s': {'tests': ['a11yr', 05:45:59 INFO - 'ts_paint', 05:45:59 INFO - 'tpaint', 05:45:59 INFO - 'sessionrestore', 05:45:59 INFO - 'sessionrestore_no_auto_restore', 05:45:59 INFO - 'tabpaint']}, 05:45:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:45:59 INFO - 'ts_paint', 05:45:59 INFO - 'tpaint', 05:45:59 INFO - 'sessionrestore', 05:45:59 INFO - 'sessionrestore_no_auto_restore', 05:45:59 INFO - 'tabpaint']}, 05:45:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:45:59 INFO - 'ts_paint', 05:45:59 INFO - 'tpaint', 05:45:59 INFO - 'sessionrestore', 05:45:59 INFO - 'sessionrestore_no_auto_restore', 05:45:59 INFO - 'tabpaint']}, 05:45:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['a11yr', 05:45:59 INFO - 'ts_paint', 05:45:59 INFO - 'tpaint', 05:45:59 INFO - 'sessionrestore', 05:45:59 INFO - 'sessionrestore_no_auto_restore', 05:45:59 INFO - 'tabpaint']}, 05:45:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['a11yr', 05:45:59 INFO - 'ts_paint', 05:45:59 INFO - 'tpaint', 05:45:59 INFO - 'sessionrestore', 05:45:59 INFO - 'sessionrestore_no_auto_restore', 05:45:59 INFO - 'tabpaint']}, 05:45:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['tsvgx', 05:45:59 INFO - 'tsvgr_opacity', 05:45:59 INFO - 'tart', 05:45:59 INFO - 'tscrollx', 05:45:59 INFO - 'cart', 05:45:59 INFO - 'tsvg_static']}, 05:45:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:45:59 INFO - 'tsvgr_opacity', 05:45:59 INFO - 'tart', 05:45:59 INFO - 'tscrollx', 05:45:59 INFO - 'cart', 05:45:59 INFO - 'tsvg_static']}, 05:45:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:45:59 INFO - 'talos_options': ['--disable-e10s'], 05:45:59 INFO - 'tests': ['tp5o']}, 05:45:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:45:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:45:59 INFO - 'talos_options': ['--disable-e10s', 05:45:59 INFO - '--xperf_path', 05:45:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:59 INFO - 'tests': ['tp5n']}, 05:45:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:45:59 INFO - 'talos_options': ['--xperf_path', 05:45:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:45:59 INFO - 'tests': ['tp5n']}}, 05:45:59 INFO - 'talos.zip': {'path': '', 05:45:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:45:59 INFO - Running post-action listener: _resource_record_post_action 05:45:59 INFO - [mozharness: 2017-01-25 13:45:59.761181Z] Finished populate-webroot step (success) 05:45:59 INFO - [mozharness: 2017-01-25 13:45:59.761320Z] Running create-virtualenv step. 05:45:59 INFO - Running pre-action listener: _resource_record_pre_action 05:45:59 INFO - Running main action method: create_virtualenv 05:45:59 INFO - Creating virtualenv /builds/slave/test/build/venv 05:45:59 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:45:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:45:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:45:59 INFO - Using real prefix '/tools/python27' 05:45:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:46:00 INFO - Installing distribute.............................................................................................................................................................................................done. 05:46:03 INFO - Installing pip.................done. 05:46:03 INFO - Return code: 0 05:46:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:46:03 INFO - Reading from file tmpfile_stdout 05:46:03 INFO - Output received: 05:46:03 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:46:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:46:03 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:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:03 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:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:03 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 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:03 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:46:03 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:46:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:03 INFO - 'HOME': '/Users/cltbld', 05:46:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:03 INFO - 'LOGNAME': 'cltbld', 05:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:03 INFO - 'MOZ_NO_REMOTE': '1', 05:46:03 INFO - 'NO_EM_RESTART': '1', 05:46:03 INFO - 'PAGER': '/bin/cat', 05:46:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:03 INFO - 'PWD': '/builds/slave/test', 05:46:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:03 INFO - 'SHELL': '/bin/bash', 05:46:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:03 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:03 INFO - 'USER': 'cltbld', 05:46:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:03 INFO - 'XPC_FLAGS': '0x0', 05:46:03 INFO - 'XPC_SERVICE_NAME': '0', 05:46:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:04 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:46:04 INFO - Cleaning up... 05:46:04 INFO - Return code: 0 05:46:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:46:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:46:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:04 INFO - 'HOME': '/Users/cltbld', 05:46:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:04 INFO - 'LOGNAME': 'cltbld', 05:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:04 INFO - 'MOZ_NO_REMOTE': '1', 05:46:04 INFO - 'NO_EM_RESTART': '1', 05:46:04 INFO - 'PAGER': '/bin/cat', 05:46:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:04 INFO - 'PWD': '/builds/slave/test', 05:46:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:04 INFO - 'SHELL': '/bin/bash', 05:46:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:04 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:04 INFO - 'USER': 'cltbld', 05:46:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:04 INFO - 'XPC_FLAGS': '0x0', 05:46:04 INFO - 'XPC_SERVICE_NAME': '0', 05:46:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:04 INFO - Downloading/unpacking psutil>=3.1.1 05:46: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:46: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:46: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:46: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:46: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:46: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:46:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:46:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:07 INFO - Installing collected packages: psutil 05:46:07 INFO - Running setup.py install for psutil 05:46:07 INFO - building 'psutil._psutil_osx' extension 05:46:07 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:46:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:46:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:46:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:46:08 INFO - building 'psutil._psutil_posix' extension 05:46:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:46:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:46:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:46:08 INFO - ^ 05:46:08 INFO - 1 warning generated. 05:46:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:46:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:46:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:46:09 INFO - Successfully installed psutil 05:46:09 INFO - Cleaning up... 05:46:09 INFO - Return code: 0 05:46:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:09 INFO - 'HOME': '/Users/cltbld', 05:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:09 INFO - 'LOGNAME': 'cltbld', 05:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:09 INFO - 'MOZ_NO_REMOTE': '1', 05:46:09 INFO - 'NO_EM_RESTART': '1', 05:46:09 INFO - 'PAGER': '/bin/cat', 05:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:09 INFO - 'PWD': '/builds/slave/test', 05:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:09 INFO - 'SHELL': '/bin/bash', 05:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:09 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:09 INFO - 'USER': 'cltbld', 05:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:09 INFO - 'XPC_FLAGS': '0x0', 05:46:09 INFO - 'XPC_SERVICE_NAME': '0', 05:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:46: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:46: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:46: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:46: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:46: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:46: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:46:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:46:12 INFO - Installing collected packages: mozsystemmonitor 05:46:12 INFO - Running setup.py install for mozsystemmonitor 05:46:12 INFO - Successfully installed mozsystemmonitor 05:46:12 INFO - Cleaning up... 05:46:12 INFO - Return code: 0 05:46:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:46:12 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:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:12 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:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:46:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:12 INFO - 'HOME': '/Users/cltbld', 05:46:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:12 INFO - 'LOGNAME': 'cltbld', 05:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:12 INFO - 'MOZ_NO_REMOTE': '1', 05:46:12 INFO - 'NO_EM_RESTART': '1', 05:46:12 INFO - 'PAGER': '/bin/cat', 05:46:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:12 INFO - 'PWD': '/builds/slave/test', 05:46:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:12 INFO - 'SHELL': '/bin/bash', 05:46:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:12 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:12 INFO - 'USER': 'cltbld', 05:46:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:12 INFO - 'XPC_FLAGS': '0x0', 05:46:12 INFO - 'XPC_SERVICE_NAME': '0', 05:46:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:12 INFO - Downloading/unpacking jsonschema==2.5.1 05:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:46:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:46:15 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:46:15 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:46:15 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:46:15 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:46:15 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:46:15 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:46:15 INFO - Downloading functools32-3.2.3-2.tar.gz 05:46:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:46:15 INFO - warning: no files found matching '*.txt' 05:46:15 INFO - no previously-included directories found matching 'build' 05:46:15 INFO - no previously-included directories found matching 'dist' 05:46:15 INFO - no previously-included directories found matching '.git*' 05:46:15 INFO - Installing collected packages: jsonschema, functools32 05:46:15 INFO - Running setup.py install for functools32 05:46:15 INFO - warning: no files found matching '*.txt' 05:46:15 INFO - no previously-included directories found matching 'build' 05:46:15 INFO - no previously-included directories found matching 'dist' 05:46:15 INFO - no previously-included directories found matching '.git*' 05:46:15 INFO - Successfully installed jsonschema functools32 05:46:15 INFO - Cleaning up... 05:46:16 INFO - Return code: 0 05:46:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:46:16 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:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:16 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:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:16 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 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:16 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:46:16 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:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:16 INFO - 'HOME': '/Users/cltbld', 05:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:16 INFO - 'LOGNAME': 'cltbld', 05:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:16 INFO - 'MOZ_NO_REMOTE': '1', 05:46:16 INFO - 'NO_EM_RESTART': '1', 05:46:16 INFO - 'PAGER': '/bin/cat', 05:46:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:16 INFO - 'PWD': '/builds/slave/test', 05:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:16 INFO - 'SHELL': '/bin/bash', 05:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:16 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:16 INFO - 'USER': 'cltbld', 05:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:16 INFO - 'XPC_FLAGS': '0x0', 05:46:16 INFO - 'XPC_SERVICE_NAME': '0', 05:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:46:16 INFO - Cleaning up... 05:46:16 INFO - Return code: 0 05:46:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:46:16 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:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:16 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:46:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:16 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 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:16 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:46:16 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:46:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:16 INFO - 'HOME': '/Users/cltbld', 05:46:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:16 INFO - 'LOGNAME': 'cltbld', 05:46:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:16 INFO - 'MOZ_NO_REMOTE': '1', 05:46:16 INFO - 'NO_EM_RESTART': '1', 05:46:16 INFO - 'PAGER': '/bin/cat', 05:46:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:16 INFO - 'PWD': '/builds/slave/test', 05:46:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:16 INFO - 'SHELL': '/bin/bash', 05:46:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:16 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:16 INFO - 'USER': 'cltbld', 05:46:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:16 INFO - 'XPC_FLAGS': '0x0', 05:46:16 INFO - 'XPC_SERVICE_NAME': '0', 05:46:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:16 INFO - Downloading/unpacking blobuploader==1.2.4 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:19 INFO - Downloading blobuploader-1.2.4.tar.gz 05:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:46:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:46:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:20 INFO - Downloading docopt-0.6.1.tar.gz 05:46:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:46:20 INFO - Installing collected packages: blobuploader, requests, docopt 05:46:20 INFO - Running setup.py install for blobuploader 05:46:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:46:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:46:20 INFO - Running setup.py install for requests 05:46:21 INFO - Running setup.py install for docopt 05:46:21 INFO - Successfully installed blobuploader requests docopt 05:46:21 INFO - Cleaning up... 05:46:21 INFO - Return code: 0 05:46:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:21 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 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:21 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:46:21 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:46:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:21 INFO - 'HOME': '/Users/cltbld', 05:46:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:21 INFO - 'LOGNAME': 'cltbld', 05:46:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:21 INFO - 'MOZ_NO_REMOTE': '1', 05:46:21 INFO - 'NO_EM_RESTART': '1', 05:46:21 INFO - 'PAGER': '/bin/cat', 05:46:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:21 INFO - 'PWD': '/builds/slave/test', 05:46:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:21 INFO - 'SHELL': '/bin/bash', 05:46:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:21 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:21 INFO - 'USER': 'cltbld', 05:46:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:21 INFO - 'XPC_FLAGS': '0x0', 05:46:21 INFO - 'XPC_SERVICE_NAME': '0', 05:46:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:21 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-YPw6cF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:21 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Sjg7L9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:21 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-vtkHis-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:21 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-oWvU6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-91222M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-5h3Dfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-EM8O6h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-MkaFFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-n9h8CL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-kcT4Jn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-RQw92r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-QwLADA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-8z7IgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:22 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-kSdwMD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:23 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-RA9ouo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:23 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Fg5moR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:23 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-xyNyHE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:46:23 INFO - Running setup.py install for manifestparser 05:46:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:46:23 INFO - Running setup.py install for mozcrash 05:46:23 INFO - Running setup.py install for mozdebug 05:46:23 INFO - Running setup.py install for mozdevice 05:46:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:46:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:46:23 INFO - Running setup.py install for mozfile 05:46:24 INFO - Running setup.py install for mozhttpd 05:46:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Running setup.py install for mozinfo 05:46:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Running setup.py install for mozInstall 05:46:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Running setup.py install for mozleak 05:46:24 INFO - Running setup.py install for mozlog 05:46:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:46:24 INFO - Running setup.py install for moznetwork 05:46:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Running setup.py install for mozprocess 05:46:25 INFO - Running setup.py install for mozprofile 05:46:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Running setup.py install for mozrunner 05:46:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Running setup.py install for mozscreenshot 05:46:25 INFO - Running setup.py install for moztest 05:46:25 INFO - Running setup.py install for mozversion 05:46:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:46:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:46:25 INFO - Cleaning up... 05:46:25 INFO - Return code: 0 05:46:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:25 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:46:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:25 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:46:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:25 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 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:25 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:46:25 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:46:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:25 INFO - 'HOME': '/Users/cltbld', 05:46:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:25 INFO - 'LOGNAME': 'cltbld', 05:46:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:25 INFO - 'MOZ_NO_REMOTE': '1', 05:46:25 INFO - 'NO_EM_RESTART': '1', 05:46:25 INFO - 'PAGER': '/bin/cat', 05:46:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:25 INFO - 'PWD': '/builds/slave/test', 05:46:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:25 INFO - 'SHELL': '/bin/bash', 05:46:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:25 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:25 INFO - 'USER': 'cltbld', 05:46:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:25 INFO - 'XPC_FLAGS': '0x0', 05:46:25 INFO - 'XPC_SERVICE_NAME': '0', 05:46:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:46:26 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-icJX2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:46:26 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:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:46:26 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-jtYzZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:46:26 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:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:46:26 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-2Z0aNI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:46:26 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:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:46:26 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Va4vq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:46:26 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:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:46:26 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-haQA5G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:46:26 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:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:46:26 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-gmMO1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:46:26 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:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:46:26 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Cjoa0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:46:26 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:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:46:26 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-YO6Lcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:46:27 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:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:46:27 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-lnh81J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:46:27 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:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:46:27 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-CUDjq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:46:27 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:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:46:27 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-vDWkiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:46:27 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:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:46:27 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-psMfuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:46:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:46:27 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-Q1ZN0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:46:27 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:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:46:27 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-5zb51V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:46:27 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:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:27 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-kA3xG0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:46:27 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:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:46:27 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-vwnkpT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:46:27 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:46:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:46:27 INFO - Running setup.py (path:/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/pip-ePItWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:46:28 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:46:28 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:46:28 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:46:28 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:46:28 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:46:28 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:46:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:46:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:46:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:46:30 INFO - Downloading blessings-1.6.tar.gz 05:46:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:46:30 INFO - Installing collected packages: blessings 05:46:30 INFO - Running setup.py install for blessings 05:46:30 INFO - Successfully installed blessings 05:46:30 INFO - Cleaning up... 05:46:31 INFO - Return code: 0 05:46:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:31 INFO - Reading from file tmpfile_stdout 05:46:31 INFO - Current package versions: 05:46:31 INFO - blessings == 1.6 05:46:31 INFO - blobuploader == 1.2.4 05:46:31 INFO - docopt == 0.6.1 05:46:31 INFO - functools32 == 3.2.3-2 05:46:31 INFO - jsonschema == 2.5.1 05:46:31 INFO - manifestparser == 1.1 05:46:31 INFO - mozInstall == 1.12 05:46:31 INFO - mozcrash == 1.0 05:46:31 INFO - mozdebug == 0.1 05:46:31 INFO - mozdevice == 0.49 05:46:31 INFO - mozfile == 1.2 05:46:31 INFO - mozhttpd == 0.7 05:46:31 INFO - mozinfo == 0.9 05:46:31 INFO - mozleak == 0.1 05:46:31 INFO - mozlog == 3.4 05:46:31 INFO - moznetwork == 0.27 05:46:31 INFO - mozprocess == 0.24 05:46:31 INFO - mozprofile == 0.28 05:46:31 INFO - mozrunner == 6.13 05:46:31 INFO - mozscreenshot == 0.1 05:46:31 INFO - mozsystemmonitor == 0.3 05:46:31 INFO - moztest == 0.8 05:46:31 INFO - mozversion == 1.4 05:46:31 INFO - psutil == 3.1.1 05:46:31 INFO - requests == 1.2.3 05:46:31 INFO - wsgiref == 0.1.2 05:46:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:46:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:32 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:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:32 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 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:32 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:46:32 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:46:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:32 INFO - 'HOME': '/Users/cltbld', 05:46:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:32 INFO - 'LOGNAME': 'cltbld', 05:46:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:32 INFO - 'MOZ_NO_REMOTE': '1', 05:46:32 INFO - 'NO_EM_RESTART': '1', 05:46:32 INFO - 'PAGER': '/bin/cat', 05:46:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:32 INFO - 'PWD': '/builds/slave/test', 05:46:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:32 INFO - 'SHELL': '/bin/bash', 05:46:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:32 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:32 INFO - 'USER': 'cltbld', 05:46:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:32 INFO - 'XPC_FLAGS': '0x0', 05:46:32 INFO - 'XPC_SERVICE_NAME': '0', 05:46:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:32 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:46:32 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:46:32 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:46:32 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:46:32 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:46:32 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:46:32 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:46:32 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:46:32 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:46:32 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:46:32 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:46:32 INFO - Cleaning up... 05:46:32 INFO - Return code: 0 05:46:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:46:32 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:46:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:46:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:32 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:46:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:46:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:46:33 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 0x10fa89b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa8c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe75a4d85c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, '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.vebn4jyhBf/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.fuVqlEr41h/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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:46:33 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:46:33 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:46:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:33 INFO - 'HOME': '/Users/cltbld', 05:46:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:33 INFO - 'LOGNAME': 'cltbld', 05:46:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:33 INFO - 'MOZ_NO_REMOTE': '1', 05:46:33 INFO - 'NO_EM_RESTART': '1', 05:46:33 INFO - 'PAGER': '/bin/cat', 05:46:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:33 INFO - 'PWD': '/builds/slave/test', 05:46:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:33 INFO - 'SHELL': '/bin/bash', 05:46:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:33 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:33 INFO - 'USER': 'cltbld', 05:46:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:33 INFO - 'XPC_FLAGS': '0x0', 05:46:33 INFO - 'XPC_SERVICE_NAME': '0', 05:46:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:46:33 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:46:33 INFO - Cleaning up... 05:46:33 INFO - Return code: 0 05:46:33 INFO - Running post-action listener: _resource_record_post_action 05:46:33 INFO - Running post-action listener: _start_resource_monitoring 05:46:33 INFO - Starting resource monitoring. 05:46:33 INFO - [mozharness: 2017-01-25 13:46:33.371403Z] Finished create-virtualenv step (success) 05:46:33 INFO - [mozharness: 2017-01-25 13:46:33.372420Z] Running install step. 05:46:33 INFO - Running pre-action listener: _resource_record_pre_action 05:46:33 INFO - Running main action method: install 05:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:46:33 INFO - Reading from file tmpfile_stdout 05:46:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:46:33 INFO - Reading from file tmpfile_stdout 05:46:33 INFO - Output received: 05:46:33 INFO - Usage: mozinstall [options] installer 05:46:33 INFO - Options: 05:46:33 INFO - -h, --help show this help message and exit 05:46:33 INFO - -d DEST, --destination=DEST 05:46:33 INFO - Directory to install application into. [default: 05:46:33 INFO - "/builds/slave/test"] 05:46:33 INFO - --app=APP Application being installed. [default: firefox] 05:46:33 INFO - mkdir: /builds/slave/test/build/application 05:46:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:46:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:46:55 INFO - Reading from file tmpfile_stdout 05:46:55 INFO - Output received: 05:46:55 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:46:55 INFO - Running post-action listener: _resource_record_post_action 05:46:55 INFO - [mozharness: 2017-01-25 13:46:55.408248Z] Finished install step (success) 05:46:55 INFO - [mozharness: 2017-01-25 13:46:55.408421Z] Running run-tests step. 05:46:55 INFO - Running pre-action listener: _resource_record_pre_action 05:46:55 INFO - Running main action method: run_tests 05:46:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:55 INFO - 2017-01-25 05:46:55.423 screenresolution[1629:7434] starting screenresolution argv=screenresolution get 05:46:55 INFO - 2017-01-25 05:46:55.425 screenresolution[1629:7434] Display 0: 1600x1200x32@60 05:46:55 INFO - 2017-01-25 05:46:55.431 screenresolution[1630:7436] starting screenresolution argv=screenresolution list 05:46:55 INFO - Available Modes on Display 0 05:46:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:55 INFO - Intel Iris: 05:46:55 INFO - Chipset Model: Intel Iris 05:46:55 INFO - Type: GPU 05:46:55 INFO - Bus: Built-In 05:46:55 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:55 INFO - Vendor: Intel (0x8086) 05:46:55 INFO - Device ID: 0x0a2e 05:46:55 INFO - Revision ID: 0x0009 05:46:55 INFO - Displays: 05:46:55 INFO - Display: 05:46:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:55 INFO - Display Serial Number: 1600x1200 60 05:46:55 INFO - Main Display: Yes 05:46:55 INFO - Mirror: Off 05:46:55 INFO - Online: Yes 05:46:55 INFO - Rotation: Supported 05:46:55 INFO - Return code: 0 05:46:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:46:55 INFO - Python 2.7.3 05:46:55 INFO - Return code: 0 05:46:55 INFO - grabbing minidump binary from tooltool 05:46:55 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:46:55 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 0x10f867d30>, '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 0x10f78edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f85cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:46:55 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:46:55 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:46:55 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:46:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:46:55 INFO - Return code: 0 05:46:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:46:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:46:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:46:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:46:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:46:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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:46:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0124 --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:46:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vebn4jyhBf/Render', 05:46:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:46:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:46:55 INFO - 'HOME': '/Users/cltbld', 05:46:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:46:55 INFO - 'LOGNAME': 'cltbld', 05:46:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:46:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:46:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:46:55 INFO - 'MOZ_NO_REMOTE': '1', 05:46:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:46:55 INFO - 'NO_EM_RESTART': '1', 05:46:55 INFO - 'PAGER': '/bin/cat', 05:46:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:46:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:46:55 INFO - 'PWD': '/builds/slave/test', 05:46:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:46:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:46:55 INFO - 'SHELL': '/bin/bash', 05:46:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.fuVqlEr41h/Listeners', 05:46:55 INFO - 'TMPDIR': '/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/', 05:46:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:46:55 INFO - 'USER': 'cltbld', 05:46:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:46:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:46:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:46:55 INFO - 'XPC_FLAGS': '0x0', 05:46:55 INFO - 'XPC_SERVICE_NAME': '0', 05:46:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:46:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0124', '--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:46:56 INFO - mozversion application_buildid: 20170125043148 05:46:56 INFO - mozversion application_changeset: 95df6209f125277b6db62402897dd125f4fda5ae 05:46:56 INFO - mozversion application_display_name: Nightly 05:46:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:46:56 INFO - mozversion application_name: Firefox 05:46:56 INFO - mozversion application_remotingname: firefox 05:46:56 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:46:56 INFO - mozversion application_vendor: Mozilla 05:46:56 INFO - mozversion application_version: 54.0a1 05:46:56 INFO - mozversion platform_buildid: 20170125043148 05:46:56 INFO - mozversion platform_changeset: 95df6209f125277b6db62402897dd125f4fda5ae 05:46:56 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:46:56 INFO - mozversion platform_version: 54.0a1 05:46:56 INFO - using testdate: 1485352016 05:46:56 INFO - actual date: 1485352016 05:46:56 INFO - starting webserver on 'localhost:49247' 05:46:56 INFO - SUITE-START | Running 2 tests 05:46:56 INFO - TEST-START | dromaeo_css 05:46:56 INFO - operating with platform_type : mac_ 05:46:56 INFO - Initialising browser for dromaeo_css test... 05:46:56 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmprDgG_6/profile http://localhost:49247/getInfo.html) 05:46:58 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 05:46:58 INFO - PROCESS | 1640 | colorDepth:24 05:46:58 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 05:46:58 INFO - PROCESS | 1640 | __metrics 05:46:58 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:46:58 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:59 INFO - TEST-INFO | 1640: exit 0 05:46:59 INFO - Browser initialized. 05:46:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:46:59 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmprDgG_6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:47:11 INFO - PROCESS | 1642 | RSS: Main: 227459072 05:47:11 INFO - PROCESS | 1642 | 05:50:15 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 05:50:16 INFO - PROCESS | 1642 | RSS: Main: 373981184 05:50:16 INFO - PROCESS | 1642 | 05:52:00 INFO - PROCESS | 1642 | ************************* 05:52:00 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 05:52:00 INFO - PROCESS | 1642 | 05:52:00 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:52:00 INFO - PROCESS | 1642 | Full stack: 05:52:00 INFO - PROCESS | 1642 | ************************* 05:53:19 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 05:53:20 INFO - PROCESS | 1642 | RSS: Main: 369205248 05:53:20 INFO - PROCESS | 1642 | 05:56:22 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 05:56:23 INFO - PROCESS | 1642 | RSS: Main: 343592960 05:56:23 INFO - PROCESS | 1642 | 05:59:25 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 05:59:26 INFO - PROCESS | 1642 | RSS: Main: 344690688 05:59:26 INFO - PROCESS | 1642 | 06:02:29 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 06:02:30 INFO - PROCESS | 1642 | RSS: Main: 334696448 06:02:30 INFO - PROCESS | 1642 | 06:05:33 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 06:05:34 INFO - PROCESS | 1642 | RSS: Main: 402255872 06:05:34 INFO - PROCESS | 1642 | 06:05:34 INFO - PROCESS | 1642 | __start_tp_report 06:05:34 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 06:05:34 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 06:05:34 INFO - PROCESS | 1642 | |i|pagename|runs| 06:05:34 INFO - PROCESS | 1642 | |0;dojo.html;2725.6047873058405;3333.316670082633;3336.9833150834243;3369.696727294543;3396.677315655012;5606.074997625392;5606.55147588193;5660.122680984444;5663;5694.943050569488;5625.943740562593;5674.432556744324;5679.318481782181;5684.403137670547;5705.25831641886;4187.958120418787;4352.782360881959;4855.150348688983;5209.088409528336;5307.548858347045;5102.438731739506;5311.814086506973;5341.172118321666;5341.545968592674;5408.3509978802595;5147.6911385317;5192.221166825007;5301.893962120736;5313.149896016638;5332.466753324676;5204.193350030751;5244.475552444763;5246.501582349671;5285.286486324374;5325.440828712968;5187.118189907725;5227.947720522822;5230.163173892197;5233.685978841244;5241.31862857826;5785.045467497858;5809.7676092956235;5819.53443724501;5832.445917637818;5857.355690874;6112.837854638568;6135.018397056449;6153.815385538441;6154.5076393888385;6157.922363586399;6185.16500272462;6228.252609686821;6231.314555398948;6234.532410069263;6241.87516249677;5978.8505287367725;5992.2809262888295;6004.759809607567;6029.751014239164;6081.7871374502565;6122.602030867979;6163.9383606164265;6167.414095660905;6213.00591905302;6221.751129954841;6117.188044311255;6121.96939015311;6130.012120365664;6152;6153.261608606996;6108.198106408921;6124.991279909952;6155.907661385083;6189.071639254148;6202.472789812826;6137.757446213422;6140.723667434976;6146.323904370515;6199.659018753921;6208.72060757267;5191.377034755778;6113.202667687823;6153.815385538441;6198.938010619836;6213.627182369072;4942.357493525818;4945.307656928033;4951.059298733229;4960.751962401865;4994.850154495371;4371.038371558252;4413.801378937956;4462;4479.641628669699;4518.88702782433;5690.715464226772;5738.426157384228;5750.683712395775;5763.8559036024435;5766.077427611562;6138.570300078952;6156.6921653917125;6204.472619827275;6213.316535181127;6247.0629405589525;5738.282714660668;5769.88460230793;5781.53747700183;5799.5650326225705;5823.388544202798;5457.945420545823;5458.563314934796;5472.753726082256;5479;5491.36849262332;6221;6228.968855155696;6264.874702505833;6295.874082518416;6310.5267104967315;5261.5264626183825;6262.624242545462;6294.992801151794;6298.527610429144;6335.588186767845;6204.292290217782;6297.338779428094;6299.181106456132;6302.338254483213;6320.4311611955145;6099.176611157437;6116.944513560587;6156.830202261556;6237.1891654084675;6257.43683068526;6226.937730622817;6303.369663033844;6314.052892066226;6328.6202827830475;6340.71466784005;6163;6164.198654174928;6173.69131543412;6174.876502470015;6175.166352542349;5849.912251316148;5984.19213406202;6106.1451396803595;6146.969265153645;6166.445019948226;5923.170756094237;5924.229850119457;5930.199423077829;5996.1005849122985;6060.181875446759;6114;6147.877042459215;6162.414570615784;6182.412670796267;6197.349278325892;5811.302643682785;5861.706914654335;5873.03094989322;5932.970335148297;6007.609505382136 06:05:34 INFO - PROCESS | 1642 | |1;ext.html;412.9099178169633;487.0721275969279;493.95554400104004;494.3030327238594;526.8908946667262;30947.38105237894;40116;42151.36772948401;42269.788651056704;44090.779546102305;43757.34363984543;43857.903552411124;43955.560444395545;43974.560254397446;43983.680489585284;8361.03848057472;9324.720258392259;9505.80988380232;9528.285378596598;9574.329796914219;8503.319734421231;11267.943660281688;11482.48328825205;11483.368414737186;11566.768664626703;11370.374629395379;11425.143114266422;11432.885671143265;11452.942735286311;11462.14033947453;8344.290735287508;11295.49170287339;11379.14656400765;11404;11406.942965285203;8379.916200837975;8505.957470212672;8513.446625969293;8524.190201930869;11021.83467247992;38720.806395968124;40580.78257652275;40645.390319145234;40850.79574602138;40902.795486022376;4016.8393264269685;4072.552019277877;4083.6324730774077;4105.527864295615;4192.224438478891;29940.550891736642;31118.688813111807;31338.843305783554;31392;31825.681743182504;3143.2927591292005;3244.1403028197547;3273.8526766295336;3304.206990322329;3352.128446603876;475183.2481675208;476008;479415.2058479405;479790;482659;63344.36655633384;63551;63671.04493432602;63770.36229637737;63985.080447586646;63409;63842.68078659577;66050.66974665193;66140.66929665417;66145;15577.14325712074;16184.271707773178;16208.51374458768;16237;16267.186640668157;11275.830862537068;11578.363190024462;12531.498740050296;12625.621231363073;12635.93682031584;15536.92231538835;17329.826701733073;17633.382831601088;17805.46583602494;17947;6990.091288132612;7096.716131354791;7134.964325178445;7184.568925864465;7194.208637050025;854.8247609240091;862.2584577263548;872.8516152254132;873.7383732436126;913.981720365589;29750.702492975226;29764.702352976627;29838.733865888407;30429.847850760605;30559.512919334462;1042.7601651620018;1049.1030169205371;1063.7340664833791;1082.2370228988543;1150.511032811052;15271.389144434099;15293.694126117416;15296.623303902703;15431.768523472158;15673.921630391775;571289;571382;574793;580097;580864;53368;61168.38831611716;61345.69327153335;61420.692896535234;61593.76812463726;1413.590058882933;1450.9274536273144;1457.4825936792286;1460.466929570699;1471.3746657670233;29119.85440072786;29121;29337.266568335963;30062.54906176453;30157.246068848453;51327;51649.741751291;51733.482665172865;51741.22388164105;51771;489771;490724;491474;493356;494846;34270.65729342774;39089;39955.60044399519;40140.79929600333;40460;40188.983795080756;41844.16311673688;50081;51137;51270.74364628153;36161;37132.44301335428;37680.623193767715;37733;40304.39543406793;35713.28573428465;35719.64280357163;36490.452643210905;36596.268074638894;36933.076673083386;34684.30631387308;34913.650863492054;35694.64305356913;35823.46264805978;35861.28277434489;30940.22649433782;32087.358252834347;32178.678213218504;32494.51258231081;32532;20950.895245523676;22628.755418451485;23533.72870262023;23687.69717665476;24135.60406492316 06:05:34 INFO - PROCESS | 1642 | |2;jquery.html;383.4708102818109;388.60362430321067;390.81103108322395;399.32115403813515;419.0654839707452;13461.798073028913;20063.699044514327;21157.94210289487;21363.893180534094;21390.358289251308;16383.262753176106;17559.473215803515;21046.737195768266;21207.045682944266;21274.46813829651;5410.296661434028;5915.08316210988;6037.305709843358;6107.5113990880845;6243.8126856194385;5828.672357962899;6043.637381757087;6085.2393450818645;6088.36072212418;6156.045812898986;6084.817455476343;6087.330393656716;6098.237720284965;6099.3290738019;6100.23747031621;5826.388229235933;6060.515158787309;6062.848428789272;6106.419890110433;6132.69336533176;5341.172118321666;5347;5360.115580929181;5365.678059316453;5369.81205657804;26079.348016299555;26768.59847102295;26824.195274141806;27040;27183;3125.6249250090136;3132.6084239470065;3139;3141.4659507883484;3213.6304325002457;10465.84301235482;15927.761083583755;16468.83531164697;16503.83496165035;16563.83436165635;1830.1215416599973;1899.3637131560943;1904.4667493101954;1911.2164012754843;1911.9713204301947;106476.46761766142;122174.55650887021;125309;129743.35128324393;134198;9397.99264235438;9657;11210.775784484427;11556.452902606796;11728.648140555626;14518;14901.70196596062;14932.32804523799;14961.40154393812;15024.399024038916;7766;8176.877346839802;8212.137725538852;8379;8484.830303393897;7003.789886303419;8608.95695521531;8714.215720585178;8768.736937891874;8862.113788621215;7391.741289054858;7490.400767938552;7492.812679683051;7494.700211991569;7525.36034437079;1841.5691287500372;1917.3672688012923;1970.7832138464757;1970.9211631534865;1972.467433792868;913.7395842184945;1005.8290090684601;1006.9043440873105;1009.5255230041869;1048.8793788714395;19710.310139145062;20351;20703.792962070187;20941.790582094287;21261.68107478358;1009.2884516415909;1024.7233247023412;1025.7948410317965;1044.3890324160452;1055.7993981143559;10014.298999069995;10830.67507974762;10854.620088296871;10883.945580272048;11078.667639970814;597096;599422;626003;627052;627343;99912.50218744444;108463;121602.39198804126;128288;131584;869.452245085592;984.8719666443317;1016.3292227130058;1017.8066167428165;1020.6580795433613;15047;17829;18140.90929545344;18340;18919.507032502024;53894.73052634712;54590.45409545854;55239.44760552343;55678.72160639171;55850;53208;76290.61854690692;76929;77114;77676.2232377669;7839.687292248915;8017.719379821679;8039.83920321602;8462.957685211535;8494.617742201492;12987.090903636654;13057.08600397963;13489.527866524624;13521;13537.323133843465;5465.918011229755;6783.626900520321;9815.96932322096;11190.048845848194;11422.31466112036;9554.713358599252;10921.399323037309;11175.217734758815;11315.660530184108;11711.945924866803;5977.820665380045;9145.719599256243;9304.813903721752;11487.655370338904;11835.82246266324;8201.30288925424;8250.257476827115;8275.83448331042;8296.087430382773;8303.1281715419;11041.613543526259;11043.33739975572;11402.543898243977;11461.942690286494;11524.250923689933 06:05:34 INFO - PROCESS | 1642 | |3;mootools.html;1454.345544504973;1456.4028748213234;1460.8100946876905;1474.9410023599057;1475.6753514226866;7966.601669916503;8383.371247156465;8386.790330241733;8393.24460798528;8413.074561798197;6856.52004359695;7322.121345438555;7577.318041376275;7627.275408836152;7920.287174154325;2247.5280191159836;2283.22370394066;2290.5876942150408;2291.9541609167804;2292.2893902890073;2296.8966396512114;2324.407276144581;2338.0764597983784;2348.976510234893;2350.9529809403803;2055.085486958304;2125.9893700531475;2135.5515341778246;2243.3270018994317;2305.723313202418;2293.7820907013806;2312.7571604981404;2316.976830231693;2317.2237300504353;2320.6519022146726;2244.9102035918545;2298.586254474194;2328.301509547146;2330.5105927755194;2336.1823361823394;8284.7100351488;8369.916300837036;8386.287165590933;8401.95799021007;8410.495370277742;5033.521815427529;5161.096808058613;5183.507566781187;5184.896302073975;5186.429492755794;3322.8670853166086;3480.6693364130365;3503.316853213624;3504.5794504659602;3579.230465449915;1142.5943789954529;1180.6186761489078;1197.21582363552;1225.662942690767;1236.7341021680381;10614.946925265402;10727.785444291148;10758.731031724192;10796.2442629016;10799.136069114453;4480.798364073625;4598.517155698671;4675.672702910763;4696.201645720235;4700.224462963641;9425.05749425052;9445.952770236105;9452.196563292197;9455.05449455049;9468.95265523668;5236.476352364733;5236.764345604457;5241.554467870197;5244.160934250502;5249.133892907704;4696.88257793551;4710.717356958594;4737.194676904935;4803;4807.062622788592;3781.9432708509394;3844.6732027777953;3870.051837299823;3875.147467557133;3966.1076257842333;1190.4404929683035;1193.5285562203055;1200.4357951762659;1202.4288462980014;1204.8975837053774;770.2374649097353;774.5004472115454;807.0517142357706;808.454293351985;817.8854960305562;5385.272988146628;5389.7035663038905;5426.294581704432;5498.972505137449;5503.422140675171;563.490041512432;571.8884817460638;589.8790747896757;913.0093848174805;935.6912218967724;3122.3911337289464;3587.0494319005484;3711.1278849470355;3777.395616701315;3812.942805857914;9583.952080239555;9828.901710982942;9859.605615775288;9871.309008369346;9929.453880036668;9892.307538472238;9907.256955728206;9915.405075695482;9915.454649994175;9933.850992235122;7275.563466192046;7663.501872378278;7665.846683066419;7791.649375778104;7797.7660670179985;5558.833235002957;5637.915431268452;5713.200151978644;5716;5759.280089988752;8797.516136612549;8892.42199257072;9024.052474490347;9163.083691630784;9179.586918588813;9161.679341223025;9278;9329.813403731752;9363.765905852135;9396.154346108882;7052.400545953651;7274.454415918933;7280.854382912206;7281.417486601165;7315.890261645973;7763.14605393395;7769.184235655401;7806.375489960676;7840.490368126054;7863;5760.769569217185;7080.114985626797;7156.964215178891;7166.964165179141;7180.856382872418;6898.275681053417;6952.617606031717;7004.054452649031;7057.047298614827;7088.822779430556;6285.340039295808;6306.306306306211;6343.238811342669;6417.1657684500715;6444.226692796894;4198.097409057067;4884.63365247615;4943.233798761198;4959.156943319716;5056.089903817348;4823.686460380064;4862.808611889968;4972.950270497248;5030.5975521957425;5115.283860259641 06:05:34 INFO - PROCESS | 1642 | |4;prototype.html;298.4046826580971;357.9856805727771;367.30212596067474;372.76515795049113;376.7306375941203;4622.144903192911;4992.528698294344;5326.813561525342;5347.304850369456;5383.892322153564;4992.425871024833;5015.724135172564;5083.771230294637;5150.939624150342;5282.788688452467;3440.7935523868646;3634.327649384859;3654.4335627977707;4115.567865374122;4161.771102589364;3587.4080776671817;3631.94552081719;3925.3513524319856;4160.251154792136;4165.229432554972;3679.576848662398;3984.0677122230522;4039.6364327210545;4077.612626800449;4147.357159640261;4060.472138621975;4065.9186816263805;4070.8398106539494;4089.9795501022604;4092.5907409258984;3177.6345720242007;3604.774376711904;3618.294432585647;3629.745917785756;3632.6185750496347;4499.955000450019;4794.35276237707;5034.798608055673;5078.739960717482;5148.742562871879;4704.259424013103;4725.149473094842;4727.3854398927915;4742.573168414825;4755.2153894607345;5132.204508301219;5468.9335579562;5473.507384335429;5524.502794748451;5530.972345138249;3546;3761.5018033229085;4009.4386785850006;4049.3521036634293;4060.654844338235;4441.689081764278;5794.478496935296;5796.449337312949;5828.446297601806;5870.6771127587535;3396.541466901986;3406.6933975942284;3809.9522631276623;3851.67260782831;3867.7872717000837;3173.6032995875516;3459.567554055743;3781.9243615127543;3913.5108111486065;3918.314294998364;3870.2066076454257;4205.243056249843;4380.817179361555;4528.660350473728;4529.343245229489;5537.667739935617;5559.221708960748;5591.051919051669;5600.887982240332;5602.38373778884;1197.5150064224003;1260.1619922751452;1271.9760592722946;1274.6813296675832;1292.4700872642172;810.3031393002013;833.6998680475024;834.5118105907991;846.3229416466802;869.665178906113;3900.108447403007;3952.881413557598;4182.56083111275;4631.3601247288725;4637.39713837199;4905.754712264444;4929.433115191727;5255.421903590602;5351.491608297283;5371.677699338053;3726.912928759849;4254.468191476066;4627.768611569475;4851.781669824866;4872.78072486739;2688.5295073362086;2857.8425737576313;2873;2878.172360551065;2885.7114288570974;4934.851954441372;5005.174146265898;5416.783328666888;5573.526250268692;5606;5307.3896501902;5531.944680553143;5626.97186514073;5760.514888492486;5831;4957.925631115464;4972.627052971042;5858.179854820329;5901.17383566301;5910.704464776744;5336.332958380202;5570.629768989865;5684.431556844283;5704.401037890962;5776.7400466979925;4833.978763272954;5108.402437806004;5631.662100273997;5656.60403771732;5698.601097923106;5052.964142350883;5840.576160893182;5866.50134738552;5867.911981320369;5930;3567.3935430977317;3802.676772474371;3824.5713971628775;3840.7531594017814;3841.2893614681375;5102.341738934787;5381.089713151775;5408.214250024919;5730.5702072345575;5737.196792448977;5513;5546.448633628576;5565.387807341108;5565.5825813063375;5582.33012038558;4035.878923632296;4861.368022157097;4937.913658995016;5273.446288139843;5575.358833734173;4953.0589188054155;5061.797528098835;5472.480114389126;5491.615586908878;5510.9448905510435;4990.80036798524;5157.819476318311;5368.892622147457;5564.916526252028;5578.748956297058;5427.484388983198;5437.5378092860965;5455.536279416294;5474.727987884983;5475.808346707846 06:05:34 INFO - PROCESS | 1642 | |5;yui.html;719.6329871765399;731.4477569435076;743.3941337809688;785.2736218997426;846.1749793950896;14121.788173177398;14941.17823519706;14987.100773953543;14988.475403360884;15005.324760385794;14502.274886255671;14728.6317842054;14732.484363047295;14745;14747.92626036871;687.4809518813314;706.2407911495163;873.8558137907238;875.426595579893;886.171429713217;879.6877108626442;882.9337799665019;887.436477836572;896.2874514760781;897.9146981036791;939.910708482693;940.5673390240497;941.6986564299427;944.3436811416069;948.037741692183;737.4911311195258;935.060264434246;935.5743136872707;938.5776400619749;938.8873335199786;561.404910794555;563.7998510528786;566.009483404043;567.4382361462123;569.1093438768314;14424.711505769827;14904.850951490454;14906.552803415914;14950.252487375588;14967.775483367759;10694.411807350592;14121.15273083608;14168.433262669481;14200.786988195185;14204.786928196085;12824.935875320656;12993;13034.283114428703;13162.868371316355;13532.93233533826;4415.867523974286;4436.3123715824095;4450.465944086698;4450.4881938577155;4511.097780443924;108134;108269.50382977046;108583.91416085817;109179;111723;11100.888991110147;11149.832752508719;11158.66096068477;11219.831702524469;11595.826062609067;22610.321690349316;22641.547169056856;22758.08967641309;22868.542629147658;22954;7292;7566.444893842176;7818.179091195342;7856.489328193649;8061.758147255592;4210.221109094766;4229.6404805591255;4252.468441444819;4312.05134870328;4392.846250381285;3447.1382154461385;3459.308138372285;3526.8941931741574;3543.8228088595465;3836.3478208704587;700.7232143303366;701.0115736811072;703.085988215318;718.4660749300177;719.0688058963655;532.2043544900322;658.9670516474157;677.5392732941647;698.5250029979662;712.3873468816813;9750.463724495221;10301.9484902575;10487.842682359771;10499.552944819952;10571.682849514527;680.3604611665019;691.1257259566652;700.8353037036293;720.1861896057421;729.5002922997763;4889;4897.804087836518;4926.852194434173;4927.95072049282;4929.285253638274;68829;86117;91301.08698912925;92273.53863230642;92594.61108083384;76089.33687320918;82589.58705206435;82974.17025829664;85895;86884;55495.72252138794;69110;69154.3084569158;76943;80384.5980770104;9090;10559.63041293551;10628.309159904582;10744.979226973424;11189.104871610089;47612.809679758284;47629.761851190524;47772.044559109316;50912.49087509078;51449.48550514447;63831.680841595495;65551.44485551407;69927.65036174786;70272;70452.29547704458;12975.351232438152;13068.8039679403;13150.671233219246;13224.669383265495;13517.526886558922;14594.416223350947;14640.474610437357;14808.037477563925;15115.31981060877;15481.071135731892;13665.350744002557;13670.11144275619;13774;13791.310434478437;14190.858091418953;13538.187708737507;13648.317584120556;13683.452661893412;13882.305884705926;13905.791413128609;13127.606171814861;13565.932170339085;13614;13717.519886803913;14047.016708830284;7646.923530764621;11075.778484430428;11594.942025290156;11785.116116291483;11859.16985810985;10011.699649010541;10608.946955265174;10668.679939601825;10785.029347358775;10857.457127143769 06:05:34 INFO - PROCESS | 1642 | __end_tp_report 06:05:34 INFO - PROCESS | 1642 | __start_cc_report 06:05:34 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,1297 06:05:34 INFO - PROCESS | 1642 | __end_cc_report 06:05:34 INFO - PROCESS | 1642 | __startTimestamp1485353134020__endTimestamp 06:05:34 INFO - PROCESS | 1642 | 06:05:34 INFO - PROCESS | 1642 | ------- Summary: start ------- 06:05:34 INFO - PROCESS | 1642 | Number of tests: 6 06:05:34 INFO - PROCESS | 1642 | 06:05:34 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5731.87 Median:5992.28 stddev:660.72 (11.0%) stddev-sans-first:619.23 06:05:34 INFO - PROCESS | 1642 | Values: 2725.6 3333.3 3337.0 3369.7 3396.7 5606.1 5606.6 5660.1 5663.0 5694.9 5625.9 5674.4 5679.3 5684.4 5705.3 4188.0 4352.8 4855.2 5209.1 5307.5 5102.4 5311.8 5341.2 5341.5 5408.4 5147.7 5192.2 5301.9 5313.1 5332.5 5204.2 5244.5 5246.5 5285.3 5325.4 5187.1 5227.9 5230.2 5233.7 5241.3 5785.0 5809.8 5819.5 5832.4 5857.4 6112.8 6135.0 6153.8 6154.5 6157.9 6185.2 6228.3 6231.3 6234.5 6241.9 5978.9 5992.3 6004.8 6029.8 6081.8 6122.6 6163.9 6167.4 6213.0 6221.8 6117.2 6122.0 6130.0 6152.0 6153.3 6108.2 6125.0 6155.9 6189.1 6202.5 6137.8 6140.7 6146.3 6199.7 6208.7 5191.4 6113.2 6153.8 6198.9 6213.6 4942.4 4945.3 4951.1 4960.8 4994.9 4371.0 4413.8 4462.0 4479.6 4518.9 5690.7 5738.4 5750.7 5763.9 5766.1 6138.6 6156.7 6204.5 6213.3 6247.1 5738.3 5769.9 5781.5 5799.6 5823.4 5457.9 5458.6 5472.8 5479.0 5491.4 6221.0 6229.0 6264.9 6295.9 6310.5 5261.5 6262.6 6295.0 6298.5 6335.6 6204.3 6297.3 6299.2 6302.3 6320.4 6099.2 6116.9 6156.8 6237.2 6257.4 6226.9 6303.4 6314.1 6328.6 6340.7 6163.0 6164.2 6173.7 6174.9 6175.2 5849.9 5984.2 6106.1 6147.0 6166.4 5923.2 5924.2 5930.2 5996.1 6060.2 6114.0 6147.9 6162.4 6182.4 6197.3 5811.3 5861.7 5873.0 5933.0 6007.6 06:05:34 INFO - PROCESS | 1642 | 06:05:34 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:66172.07 Median:38904.90 stddev:137646.52 (353.8%) stddev-sans-first:137944.11 06:05:34 INFO - PROCESS | 1642 | Values: 412.9 487.1 494.0 494.3 526.9 30947.4 40116.0 42151.4 42269.8 44090.8 43757.3 43857.9 43955.6 43974.6 43983.7 8361.0 9324.7 9505.8 9528.3 9574.3 8503.3 11267.9 11482.5 11483.4 11566.8 11370.4 11425.1 11432.9 11452.9 11462.1 8344.3 11295.5 11379.1 11404.0 11406.9 8379.9 8506.0 8513.4 8524.2 11021.8 38720.8 40580.8 40645.4 40850.8 40902.8 4016.8 4072.6 4083.6 4105.5 4192.2 29940.6 31118.7 31338.8 31392.0 31825.7 3143.3 3244.1 3273.9 3304.2 3352.1 475183.2 476008.0 479415.2 479790.0 482659.0 63344.4 63551.0 63671.0 63770.4 63985.1 63409.0 63842.7 66050.7 66140.7 66145.0 15577.1 16184.3 16208.5 16237.0 16267.2 11275.8 11578.4 12531.5 12625.6 12635.9 15536.9 17329.8 17633.4 17805.5 17947.0 6990.1 7096.7 7135.0 7184.6 7194.2 854.8 862.3 872.9 873.7 914.0 29750.7 29764.7 29838.7 30429.8 30559.5 1042.8 1049.1 1063.7 1082.2 1150.5 15271.4 15293.7 15296.6 15431.8 15673.9 571289.0 571382.0 574793.0 580097.0 580864.0 53368.0 61168.4 61345.7 61420.7 61593.8 1413.6 1450.9 1457.5 1460.5 1471.4 29119.9 29121.0 29337.3 30062.5 30157.2 51327.0 51649.7 51733.5 51741.2 51771.0 489771.0 490724.0 491474.0 493356.0 494846.0 34270.7 39089.0 39955.6 40140.8 40460.0 40189.0 41844.2 50081.0 51137.0 51270.7 36161.0 37132.4 37680.6 37733.0 40304.4 35713.3 35719.6 36490.5 36596.3 36933.1 34684.3 34913.7 35694.6 35823.5 35861.3 30940.2 32087.4 32178.7 32494.5 32532.0 20950.9 22628.8 23533.7 23687.7 24135.6 06:05:34 INFO - PROCESS | 1642 | 06:05:34 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:35392.62 Median:27111.50 stddev:102429.84 (377.8%) stddev-sans-first:102683.46 06:05:34 INFO - PROCESS | 1642 | Values: 383.5 388.6 390.8 399.3 419.1 13461.8 20063.7 21157.9 21363.9 21390.4 16383.3 17559.5 21046.7 21207.0 21274.5 5410.3 5915.1 6037.3 6107.5 6243.8 5828.7 6043.6 6085.2 6088.4 6156.0 6084.8 6087.3 6098.2 6099.3 6100.2 5826.4 6060.5 6062.8 6106.4 6132.7 5341.2 5347.0 5360.1 5365.7 5369.8 26079.3 26768.6 26824.2 27040.0 27183.0 3125.6 3132.6 3139.0 3141.5 3213.6 10465.8 15927.8 16468.8 16503.8 16563.8 1830.1 1899.4 1904.5 1911.2 1912.0 106476.5 122174.6 125309.0 129743.4 134198.0 9398.0 9657.0 11210.8 11556.5 11728.6 14518.0 14901.7 14932.3 14961.4 15024.4 7766.0 8176.9 8212.1 8379.0 8484.8 7003.8 8609.0 8714.2 8768.7 8862.1 7391.7 7490.4 7492.8 7494.7 7525.4 1841.6 1917.4 1970.8 1970.9 1972.5 913.7 1005.8 1006.9 1009.5 1048.9 19710.3 20351.0 20703.8 20941.8 21261.7 1009.3 1024.7 1025.8 1044.4 1055.8 10014.3 10830.7 10854.6 10883.9 11078.7 597096.0 599422.0 626003.0 627052.0 627343.0 99912.5 108463.0 121602.4 128288.0 131584.0 869.5 984.9 1016.3 1017.8 1020.7 15047.0 17829.0 18140.9 18340.0 18919.5 53894.7 54590.5 55239.4 55678.7 55850.0 53208.0 76290.6 76929.0 77114.0 77676.2 7839.7 8017.7 8039.8 8463.0 8494.6 12987.1 13057.1 13489.5 13521.0 13537.3 5465.9 6783.6 9816.0 11190.0 11422.3 9554.7 10921.4 11175.2 11315.7 11711.9 5977.8 9145.7 9304.8 11487.7 11835.8 8201.3 8250.3 8275.8 8296.1 8303.1 11041.6 11043.3 11402.5 11461.9 11524.3 06:05:34 INFO - PROCESS | 1642 | 06:05:34 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:5379.83 Median:5387.49 stddev:2937.15 (54.5%) stddev-sans-first:2930.57 06:05:34 INFO - PROCESS | 1642 | Values: 1454.3 1456.4 1460.8 1474.9 1475.7 7966.6 8383.4 8386.8 8393.2 8413.1 6856.5 7322.1 7577.3 7627.3 7920.3 2247.5 2283.2 2290.6 2292.0 2292.3 2296.9 2324.4 2338.1 2349.0 2351.0 2055.1 2126.0 2135.6 2243.3 2305.7 2293.8 2312.8 2317.0 2317.2 2320.7 2244.9 2298.6 2328.3 2330.5 2336.2 8284.7 8369.9 8386.3 8402.0 8410.5 5033.5 5161.1 5183.5 5184.9 5186.4 3322.9 3480.7 3503.3 3504.6 3579.2 1142.6 1180.6 1197.2 1225.7 1236.7 10614.9 10727.8 10758.7 10796.2 10799.1 4480.8 4598.5 4675.7 4696.2 4700.2 9425.1 9446.0 9452.2 9455.1 9469.0 5236.5 5236.8 5241.6 5244.2 5249.1 4696.9 4710.7 4737.2 4803.0 4807.1 3781.9 3844.7 3870.1 3875.1 3966.1 1190.4 1193.5 1200.4 1202.4 1204.9 770.2 774.5 807.1 808.5 817.9 5385.3 5389.7 5426.3 5499.0 5503.4 563.5 571.9 589.9 913.0 935.7 3122.4 3587.0 3711.1 3777.4 3812.9 9584.0 9828.9 9859.6 9871.3 9929.5 9892.3 9907.3 9915.4 9915.5 9933.9 7275.6 7663.5 7665.8 7791.6 7797.8 5558.8 5637.9 5713.2 5716.0 5759.3 8797.5 8892.4 9024.1 9163.1 9179.6 9161.7 9278.0 9329.8 9363.8 9396.2 7052.4 7274.5 7280.9 7281.4 7315.9 7763.1 7769.2 7806.4 7840.5 7863.0 5760.8 7080.1 7157.0 7167.0 7180.9 6898.3 6952.6 7004.1 7057.0 7088.8 6285.3 6306.3 6343.2 6417.2 6444.2 4198.1 4884.6 4943.2 4959.2 5056.1 4823.7 4862.8 4973.0 5030.6 5115.3 06:05:34 INFO - PROCESS | 1642 | 06:05:34 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4427.23 Median:4945.49 stddev:1358.32 (27.5%) stddev-sans-first:1326.30 06:05:34 INFO - PROCESS | 1642 | Values: 298.4 358.0 367.3 372.8 376.7 4622.1 4992.5 5326.8 5347.3 5383.9 4992.4 5015.7 5083.8 5150.9 5282.8 3440.8 3634.3 3654.4 4115.6 4161.8 3587.4 3631.9 3925.4 4160.3 4165.2 3679.6 3984.1 4039.6 4077.6 4147.4 4060.5 4065.9 4070.8 4090.0 4092.6 3177.6 3604.8 3618.3 3629.7 3632.6 4500.0 4794.4 5034.8 5078.7 5148.7 4704.3 4725.1 4727.4 4742.6 4755.2 5132.2 5468.9 5473.5 5524.5 5531.0 3546.0 3761.5 4009.4 4049.4 4060.7 4441.7 5794.5 5796.4 5828.4 5870.7 3396.5 3406.7 3810.0 3851.7 3867.8 3173.6 3459.6 3781.9 3913.5 3918.3 3870.2 4205.2 4380.8 4528.7 4529.3 5537.7 5559.2 5591.1 5600.9 5602.4 1197.5 1260.2 1272.0 1274.7 1292.5 810.3 833.7 834.5 846.3 869.7 3900.1 3952.9 4182.6 4631.4 4637.4 4905.8 4929.4 5255.4 5351.5 5371.7 3726.9 4254.5 4627.8 4851.8 4872.8 2688.5 2857.8 2873.0 2878.2 2885.7 4934.9 5005.2 5416.8 5573.5 5606.0 5307.4 5531.9 5627.0 5760.5 5831.0 4957.9 4972.6 5858.2 5901.2 5910.7 5336.3 5570.6 5684.4 5704.4 5776.7 4834.0 5108.4 5631.7 5656.6 5698.6 5053.0 5840.6 5866.5 5867.9 5930.0 3567.4 3802.7 3824.6 3840.8 3841.3 5102.3 5381.1 5408.2 5730.6 5737.2 5513.0 5546.4 5565.4 5565.6 5582.3 4035.9 4861.4 4937.9 5273.4 5575.4 4953.1 5061.8 5472.5 5491.6 5510.9 4990.8 5157.8 5368.9 5564.9 5578.7 5427.5 5437.5 5455.5 5474.7 5475.8 06:05:34 INFO - PROCESS | 1642 | 06:05:34 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:19827.85 Median:4352.45 stddev:27675.98 (635.9%) stddev-sans-first:27716.42 06:05:34 INFO - PROCESS | 1642 | Values: 719.6 731.4 743.4 785.3 846.2 14121.8 14941.2 14987.1 14988.5 15005.3 14502.3 14728.6 14732.5 14745.0 14747.9 687.5 706.2 873.9 875.4 886.2 879.7 882.9 887.4 896.3 897.9 939.9 940.6 941.7 944.3 948.0 737.5 935.1 935.6 938.6 938.9 561.4 563.8 566.0 567.4 569.1 14424.7 14904.9 14906.6 14950.3 14967.8 10694.4 14121.2 14168.4 14200.8 14204.8 12824.9 12993.0 13034.3 13162.9 13532.9 4415.9 4436.3 4450.5 4450.5 4511.1 108134.0 108269.5 108583.9 109179.0 111723.0 11100.9 11149.8 11158.7 11219.8 11595.8 22610.3 22641.5 22758.1 22868.5 22954.0 7292.0 7566.4 7818.2 7856.5 8061.8 4210.2 4229.6 4252.5 4312.1 4392.8 3447.1 3459.3 3526.9 3543.8 3836.3 700.7 701.0 703.1 718.5 719.1 532.2 659.0 677.5 698.5 712.4 9750.5 10301.9 10487.8 10499.6 10571.7 680.4 691.1 700.8 720.2 729.5 4889.0 4897.8 4926.9 4928.0 4929.3 68829.0 86117.0 91301.1 92273.5 92594.6 76089.3 82589.6 82974.2 85895.0 86884.0 55495.7 69110.0 69154.3 76943.0 80384.6 9090.0 10559.6 10628.3 10745.0 11189.1 47612.8 47629.8 47772.0 50912.5 51449.5 63831.7 65551.4 69927.7 70272.0 70452.3 12975.4 13068.8 13150.7 13224.7 13517.5 14594.4 14640.5 14808.0 15115.3 15481.1 13665.4 13670.1 13774.0 13791.3 14190.9 13538.2 13648.3 13683.5 13882.3 13905.8 13127.6 13565.9 13614.0 13717.5 14047.0 7646.9 11075.8 11594.9 11785.1 11859.2 10011.7 10608.9 10668.7 10785.0 10857.5 06:05:34 INFO - PROCESS | 1642 | -------- Summary: end -------- 06:05:34 INFO - PROCESS | 1642 | 06:05:34 INFO - TEST-INFO | 1642: exit 0 06:05:34 INFO - TEST-OK | dromaeo_css | took 1118668ms 06:05:34 INFO - TEST-START | kraken 06:05:34 INFO - operating with platform_type : mac_ 06:05:34 INFO - Initialising browser for kraken test... 06:05:34 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmphDAcxl/profile http://localhost:49247/getInfo.html) 06:05:36 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 06:05:36 INFO - PROCESS | 1652 | colorDepth:24 06:05:36 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 06:05:36 INFO - PROCESS | 1652 | __metrics 06:05:37 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:05:37 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:05:37 INFO - TEST-INFO | 1652: exit 0 06:05:37 INFO - Browser initialized. 06:05:37 INFO - Running cycle 1/1 for kraken test... 06:05:37 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/T/tmphDAcxl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:05:49 INFO - PROCESS | 1653 | RSS: Main: 235970560 06:05:49 INFO - PROCESS | 1653 | 06:05:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 06:05:53 INFO - PROCESS | 1653 | RSS: Main: 288768000 06:05:53 INFO - PROCESS | 1653 | 06:05:56 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 06:05:56 INFO - PROCESS | 1653 | RSS: Main: 289243136 06:05:56 INFO - PROCESS | 1653 | 06:06:00 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 06:06:00 INFO - PROCESS | 1653 | RSS: Main: 379904000 06:06:00 INFO - PROCESS | 1653 | 06:06:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 06:06:03 INFO - PROCESS | 1653 | RSS: Main: 282386432 06:06:03 INFO - PROCESS | 1653 | 06:06:05 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:06:05 INFO - PROCESS | 1653 | RSS: Main: 286142464 06:06:05 INFO - PROCESS | 1653 | 06:06:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 06:06:09 INFO - PROCESS | 1653 | RSS: Main: 326959104 06:06:09 INFO - PROCESS | 1653 | 06:06:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 06:06:12 INFO - PROCESS | 1653 | RSS: Main: 329768960 06:06:12 INFO - PROCESS | 1653 | 06:06:15 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 06:06:16 INFO - PROCESS | 1653 | RSS: Main: 326508544 06:06:16 INFO - PROCESS | 1653 | 06:06:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:06:18 INFO - PROCESS | 1653 | RSS: Main: 304398336 06:06:18 INFO - PROCESS | 1653 | 06:06:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:06:21 INFO - PROCESS | 1653 | RSS: Main: 310104064 06:06:21 INFO - PROCESS | 1653 | 06:06:23 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:06:23 INFO - PROCESS | 1653 | RSS: Main: 311054336 06:06:23 INFO - PROCESS | 1653 | 06:06:26 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:06:27 INFO - PROCESS | 1653 | RSS: Main: 328134656 06:06:27 INFO - PROCESS | 1653 | 06:06:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:06:31 INFO - PROCESS | 1653 | RSS: Main: 322334720 06:06:31 INFO - PROCESS | 1653 | 06:06:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 06:06:33 INFO - PROCESS | 1653 | RSS: Main: 366911488 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | __start_tp_report 06:06:33 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 06:06:33 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 06:06:33 INFO - PROCESS | 1653 | |i|pagename|runs| 06:06:33 INFO - PROCESS | 1653 | |0;ai-astar;115;116;114;114;114;115;113;114;113;114 06:06:33 INFO - PROCESS | 1653 | |1;audio-beat-detection;140;108;107;168;111;109;111;113;149;110 06:06:33 INFO - PROCESS | 1653 | |2;audio-dft;186;185;185;184;184;180;183;182;183;185 06:06:33 INFO - PROCESS | 1653 | |3;audio-fft;83;59;59;86;62;58;59;58;77;59 06:06:33 INFO - PROCESS | 1653 | |4;audio-oscillator;84;84;117;95;68;70;82;67;70;84 06:06:33 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;88;84;87;85;88;84;90;86;89;84 06:06:33 INFO - PROCESS | 1653 | |6;imaging-darkroom;96;95;95;95;97;96;95;96;96;108 06:06:33 INFO - PROCESS | 1653 | |7;imaging-desaturate;86;86;85;84;85;85;86;87;87;85 06:06:33 INFO - PROCESS | 1653 | |8;json-parse-financial;57;52;53;55;56;56;54;54;53;54 06:06:33 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;70;72;79;73;74;72;71;72;71;74 06:06:33 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;85;87;87;89;87;86;86;87;88;85 06:06:33 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;138;139;139;137;137;142;143;154;212;154 06:06:33 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;173;175;173;172;173;172;172;175;175;171 06:06:33 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;67;67;68;67;68;68;67;69;66;67 06:06:33 INFO - PROCESS | 1653 | __end_tp_report 06:06:33 INFO - PROCESS | 1653 | __start_cc_report 06:06:33 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,1958 06:06:33 INFO - PROCESS | 1653 | __end_cc_report 06:06:33 INFO - PROCESS | 1653 | __startTimestamp1485353193144__endTimestamp 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | ------- Summary: start ------- 06:06:33 INFO - PROCESS | 1653 | Number of tests: 14 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.93 06:06:33 INFO - PROCESS | 1653 | Values: 115.0 116.0 114.0 114.0 114.0 115.0 113.0 114.0 113.0 114.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:122.60 Median:112.00 stddev:21.66 (19.3%) stddev-sans-first:22.04 06:06:33 INFO - PROCESS | 1653 | Values: 140.0 108.0 107.0 168.0 111.0 109.0 111.0 113.0 149.0 110.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:183.70 Median:184.50 stddev:1.77 (1.0%) stddev-sans-first:1.67 06:06:33 INFO - PROCESS | 1653 | Values: 186.0 185.0 185.0 184.0 184.0 180.0 183.0 182.0 183.0 185.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:11.30 (18.7%) stddev-sans-first:10.18 06:06:33 INFO - PROCESS | 1653 | Values: 83.0 59.0 59.0 86.0 62.0 58.0 59.0 58.0 77.0 59.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:82.10 Median:83.00 stddev:15.33 (18.5%) stddev-sans-first:16.24 06:06:33 INFO - PROCESS | 1653 | Values: 84.0 84.0 117.0 95.0 68.0 70.0 82.0 67.0 70.0 84.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.50 stddev:2.22 (2.5%) stddev-sans-first:2.29 06:06:33 INFO - PROCESS | 1653 | Values: 88.0 84.0 87.0 85.0 88.0 84.0 90.0 86.0 89.0 84.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:96.00 stddev:3.96 (4.1%) stddev-sans-first:4.18 06:06:33 INFO - PROCESS | 1653 | Values: 96.0 95.0 95.0 95.0 97.0 96.0 95.0 96.0 96.0 108.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 06:06:33 INFO - PROCESS | 1653 | Values: 86.0 86.0 85.0 84.0 85.0 85.0 86.0 87.0 87.0 85.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:54.50 stddev:1.58 (2.9%) stddev-sans-first:1.36 06:06:33 INFO - PROCESS | 1653 | Values: 57.0 52.0 53.0 55.0 56.0 56.0 54.0 54.0 53.0 54.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:72.80 Median:72.50 stddev:2.53 (3.5%) stddev-sans-first:2.47 06:06:33 INFO - PROCESS | 1653 | Values: 70.0 72.0 79.0 73.0 74.0 72.0 71.0 72.0 71.0 74.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:1.25 (1.4%) stddev-sans-first:1.17 06:06:33 INFO - PROCESS | 1653 | Values: 85.0 87.0 87.0 89.0 87.0 86.0 86.0 87.0 88.0 85.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:142.50 stddev:22.88 (16.1%) stddev-sans-first:23.88 06:06:33 INFO - PROCESS | 1653 | Values: 138.0 139.0 139.0 137.0 137.0 142.0 143.0 154.0 212.0 154.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.10 Median:173.00 stddev:1.45 (0.8%) stddev-sans-first:1.54 06:06:33 INFO - PROCESS | 1653 | Values: 173.0 175.0 173.0 172.0 173.0 172.0 172.0 175.0 175.0 171.0 06:06:33 INFO - PROCESS | 1653 | 06:06:33 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.40 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.88 06:06:33 INFO - PROCESS | 1653 | Values: 67.0 67.0 68.0 67.0 68.0 68.0 67.0 69.0 66.0 67.0 06:06:33 INFO - PROCESS | 1653 | -------- Summary: end -------- 06:06:33 INFO - PROCESS | 1653 | 06:06:34 INFO - TEST-INFO | 1653: exit 0 06:06:34 INFO - TEST-OK | kraken | took 59403ms 06:06:34 INFO - SUITE-END | took 1178s 06:06:34 INFO - Completed test suite (00:19:38) 06:06:34 INFO - javascript benchmark 06:06:34 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2725.6047873058405, 3333.316670082633, 3336.9833150834243, 3369.696727294543, 3396.677315655012, 5606.074997625392, 5606.55147588193, 5660.122680984444, 5663.0, 5694.943050569488, 5625.943740562593, 5674.432556744324, 5679.318481782181, 5684.403137670547, 5705.25831641886, 4187.958120418787, 4352.782360881959, 4855.150348688983, 5209.088409528336, 5307.548858347045, 5102.438731739506, 5311.814086506973, 5341.172118321666, 5341.545968592674, 5408.3509978802595, 5147.6911385317, 5192.221166825007, 5301.893962120736, 5313.149896016638, 5332.466753324676, 5204.193350030751, 5244.475552444763, 5246.501582349671, 5285.286486324374, 5325.440828712968, 5187.118189907725, 5227.947720522822, 5230.163173892197, 5233.685978841244, 5241.31862857826, 5785.045467497858, 5809.7676092956235, 5819.53443724501, 5832.445917637818, 5857.355690874, 6112.837854638568, 6135.018397056449, 6153.815385538441, 6154.5076393888385, 6157.922363586399, 6185.16500272462, 6228.252609686821, 6231.314555398948, 6234.532410069263, 6241.87516249677, 5978.8505287367725, 5992.2809262888295, 6004.759809607567, 6029.751014239164, 6081.7871374502565, 6122.602030867979, 6163.9383606164265, 6167.414095660905, 6213.00591905302, 6221.751129954841, 6117.188044311255, 6121.96939015311, 6130.012120365664, 6152.0, 6153.261608606996, 6108.198106408921, 6124.991279909952, 6155.907661385083, 6189.071639254148, 6202.472789812826, 6137.757446213422, 6140.723667434976, 6146.323904370515, 6199.659018753921, 6208.72060757267, 5191.377034755778, 6113.202667687823, 6153.815385538441, 6198.938010619836, 6213.627182369072, 4942.357493525818, 4945.307656928033, 4951.059298733229, 4960.751962401865, 4994.850154495371, 4371.038371558252, 4413.801378937956, 4462.0, 4479.641628669699, 4518.88702782433, 5690.715464226772, 5738.426157384228, 5750.683712395775, 5763.8559036024435, 5766.077427611562, 6138.570300078952, 6156.6921653917125, 6204.472619827275, 6213.316535181127, 6247.0629405589525, 5738.282714660668, 5769.88460230793, 5781.53747700183, 5799.5650326225705, 5823.388544202798, 5457.945420545823, 5458.563314934796, 5472.753726082256, 5479.0, 5491.36849262332, 6221.0, 6228.968855155696, 6264.874702505833, 6295.874082518416, 6310.5267104967315, 5261.5264626183825, 6262.624242545462, 6294.992801151794, 6298.527610429144, 6335.588186767845, 6204.292290217782, 6297.338779428094, 6299.181106456132, 6302.338254483213, 6320.4311611955145, 6099.176611157437, 6116.944513560587, 6156.830202261556, 6237.1891654084675, 6257.43683068526, 6226.937730622817, 6303.369663033844, 6314.052892066226, 6328.6202827830475, 6340.71466784005, 6163.0, 6164.198654174928, 6173.69131543412, 6174.876502470015, 6175.166352542349, 5849.912251316148, 5984.19213406202, 6106.1451396803595, 6146.969265153645, 6166.445019948226, 5923.170756094237, 5924.229850119457, 5930.199423077829, 5996.1005849122985, 6060.181875446759, 6114.0, 6147.877042459215, 6162.414570615784, 6182.412670796267, 6197.349278325892, 5811.302643682785, 5861.706914654335, 5873.03094989322, 5932.970335148297, 6007.609505382136], "value": 5687.743951326967, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [412.9099178169633, 487.0721275969279, 493.95554400104004, 494.3030327238594, 526.8908946667262, 30947.38105237894, 40116.0, 42151.36772948401, 42269.788651056704, 44090.779546102305, 43757.34363984543, 43857.903552411124, 43955.560444395545, 43974.560254397446, 43983.680489585284, 8361.03848057472, 9324.720258392259, 9505.80988380232, 9528.285378596598, 9574.329796914219, 8503.319734421231, 11267.943660281688, 11482.48328825205, 11483.368414737186, 11566.768664626703, 11370.374629395379, 11425.143114266422, 11432.885671143265, 11452.942735286311, 11462.14033947453, 8344.290735287508, 11295.49170287339, 11379.14656400765, 11404.0, 11406.942965285203, 8379.916200837975, 8505.957470212672, 8513.446625969293, 8524.190201930869, 11021.83467247992, 38720.806395968124, 40580.78257652275, 40645.390319145234, 40850.79574602138, 40902.795486022376, 4016.8393264269685, 4072.552019277877, 4083.6324730774077, 4105.527864295615, 4192.224438478891, 29940.550891736642, 31118.688813111807, 31338.843305783554, 31392.0, 31825.681743182504, 3143.2927591292005, 3244.1403028197547, 3273.8526766295336, 3304.206990322329, 3352.128446603876, 475183.2481675208, 476008.0, 479415.2058479405, 479790.0, 482659.0, 63344.36655633384, 63551.0, 63671.04493432602, 63770.36229637737, 63985.080447586646, 63409.0, 63842.68078659577, 66050.66974665193, 66140.66929665417, 66145.0, 15577.14325712074, 16184.271707773178, 16208.51374458768, 16237.0, 16267.186640668157, 11275.830862537068, 11578.363190024462, 12531.498740050296, 12625.621231363073, 12635.93682031584, 15536.92231538835, 17329.826701733073, 17633.382831601088, 17805.46583602494, 17947.0, 6990.091288132612, 7096.716131354791, 7134.964325178445, 7184.568925864465, 7194.208637050025, 854.8247609240091, 862.2584577263548, 872.8516152254132, 873.7383732436126, 913.981720365589, 29750.702492975226, 29764.702352976627, 29838.733865888407, 30429.847850760605, 30559.512919334462, 1042.7601651620018, 1049.1030169205371, 1063.7340664833791, 1082.2370228988543, 1150.511032811052, 15271.389144434099, 15293.694126117416, 15296.623303902703, 15431.768523472158, 15673.921630391775, 571289.0, 571382.0, 574793.0, 580097.0, 580864.0, 53368.0, 61168.38831611716, 61345.69327153335, 61420.692896535234, 61593.76812463726, 1413.590058882933, 1450.9274536273144, 1457.4825936792286, 1460.466929570699, 1471.3746657670233, 29119.85440072786, 29121.0, 29337.266568335963, 30062.54906176453, 30157.246068848453, 51327.0, 51649.741751291, 51733.482665172865, 51741.22388164105, 51771.0, 489771.0, 490724.0, 491474.0, 493356.0, 494846.0, 34270.65729342774, 39089.0, 39955.60044399519, 40140.79929600333, 40460.0, 40188.983795080756, 41844.16311673688, 50081.0, 51137.0, 51270.74364628153, 36161.0, 37132.44301335428, 37680.623193767715, 37733.0, 40304.39543406793, 35713.28573428465, 35719.64280357163, 36490.452643210905, 36596.268074638894, 36933.076673083386, 34684.30631387308, 34913.650863492054, 35694.64305356913, 35823.46264805978, 35861.28277434489, 30940.22649433782, 32087.358252834347, 32178.678213218504, 32494.51258231081, 32532.0, 20950.895245523676, 22628.755418451485, 23533.72870262023, 23687.69717665476, 24135.60406492316], "value": 20087.929272530204, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.4708102818109, 388.60362430321067, 390.81103108322395, 399.32115403813515, 419.0654839707452, 13461.798073028913, 20063.699044514327, 21157.94210289487, 21363.893180534094, 21390.358289251308, 16383.262753176106, 17559.473215803515, 21046.737195768266, 21207.045682944266, 21274.46813829651, 5410.296661434028, 5915.08316210988, 6037.305709843358, 6107.5113990880845, 6243.8126856194385, 5828.672357962899, 6043.637381757087, 6085.2393450818645, 6088.36072212418, 6156.045812898986, 6084.817455476343, 6087.330393656716, 6098.237720284965, 6099.3290738019, 6100.23747031621, 5826.388229235933, 6060.515158787309, 6062.848428789272, 6106.419890110433, 6132.69336533176, 5341.172118321666, 5347.0, 5360.115580929181, 5365.678059316453, 5369.81205657804, 26079.348016299555, 26768.59847102295, 26824.195274141806, 27040.0, 27183.0, 3125.6249250090136, 3132.6084239470065, 3139.0, 3141.4659507883484, 3213.6304325002457, 10465.84301235482, 15927.761083583755, 16468.83531164697, 16503.83496165035, 16563.83436165635, 1830.1215416599973, 1899.3637131560943, 1904.4667493101954, 1911.2164012754843, 1911.9713204301947, 106476.46761766142, 122174.55650887021, 125309.0, 129743.35128324393, 134198.0, 9397.99264235438, 9657.0, 11210.775784484427, 11556.452902606796, 11728.648140555626, 14518.0, 14901.70196596062, 14932.32804523799, 14961.40154393812, 15024.399024038916, 7766.0, 8176.877346839802, 8212.137725538852, 8379.0, 8484.830303393897, 7003.789886303419, 8608.95695521531, 8714.215720585178, 8768.736937891874, 8862.113788621215, 7391.741289054858, 7490.400767938552, 7492.812679683051, 7494.700211991569, 7525.36034437079, 1841.5691287500372, 1917.3672688012923, 1970.7832138464757, 1970.9211631534865, 1972.467433792868, 913.7395842184945, 1005.8290090684601, 1006.9043440873105, 1009.5255230041869, 1048.8793788714395, 19710.310139145062, 20351.0, 20703.792962070187, 20941.790582094287, 21261.68107478358, 1009.2884516415909, 1024.7233247023412, 1025.7948410317965, 1044.3890324160452, 1055.7993981143559, 10014.298999069995, 10830.67507974762, 10854.620088296871, 10883.945580272048, 11078.667639970814, 597096.0, 599422.0, 626003.0, 627052.0, 627343.0, 99912.50218744444, 108463.0, 121602.39198804126, 128288.0, 131584.0, 869.452245085592, 984.8719666443317, 1016.3292227130058, 1017.8066167428165, 1020.6580795433613, 15047.0, 17829.0, 18140.90929545344, 18340.0, 18919.507032502024, 53894.73052634712, 54590.45409545854, 55239.44760552343, 55678.72160639171, 55850.0, 53208.0, 76290.61854690692, 76929.0, 77114.0, 77676.2232377669, 7839.687292248915, 8017.719379821679, 8039.83920321602, 8462.957685211535, 8494.617742201492, 12987.090903636654, 13057.08600397963, 13489.527866524624, 13521.0, 13537.323133843465, 5465.918011229755, 6783.626900520321, 9815.96932322096, 11190.048845848194, 11422.31466112036, 9554.713358599252, 10921.399323037309, 11175.217734758815, 11315.660530184108, 11711.945924866803, 5977.820665380045, 9145.719599256243, 9304.813903721752, 11487.655370338904, 11835.82246266324, 8201.30288925424, 8250.257476827115, 8275.83448331042, 8296.087430382773, 8303.1281715419, 11041.613543526259, 11043.33739975572, 11402.543898243977, 11461.942690286494, 11524.250923689933], "value": 9834.826240344782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.345544504973, 1456.4028748213234, 1460.8100946876905, 1474.9410023599057, 1475.6753514226866, 7966.601669916503, 8383.371247156465, 8386.790330241733, 8393.24460798528, 8413.074561798197, 6856.52004359695, 7322.121345438555, 7577.318041376275, 7627.275408836152, 7920.287174154325, 2247.5280191159836, 2283.22370394066, 2290.5876942150408, 2291.9541609167804, 2292.2893902890073, 2296.8966396512114, 2324.407276144581, 2338.0764597983784, 2348.976510234893, 2350.9529809403803, 2055.085486958304, 2125.9893700531475, 2135.5515341778246, 2243.3270018994317, 2305.723313202418, 2293.7820907013806, 2312.7571604981404, 2316.976830231693, 2317.2237300504353, 2320.6519022146726, 2244.9102035918545, 2298.586254474194, 2328.301509547146, 2330.5105927755194, 2336.1823361823394, 8284.7100351488, 8369.916300837036, 8386.287165590933, 8401.95799021007, 8410.495370277742, 5033.521815427529, 5161.096808058613, 5183.507566781187, 5184.896302073975, 5186.429492755794, 3322.8670853166086, 3480.6693364130365, 3503.316853213624, 3504.5794504659602, 3579.230465449915, 1142.5943789954529, 1180.6186761489078, 1197.21582363552, 1225.662942690767, 1236.7341021680381, 10614.946925265402, 10727.785444291148, 10758.731031724192, 10796.2442629016, 10799.136069114453, 4480.798364073625, 4598.517155698671, 4675.672702910763, 4696.201645720235, 4700.224462963641, 9425.05749425052, 9445.952770236105, 9452.196563292197, 9455.05449455049, 9468.95265523668, 5236.476352364733, 5236.764345604457, 5241.554467870197, 5244.160934250502, 5249.133892907704, 4696.88257793551, 4710.717356958594, 4737.194676904935, 4803.0, 4807.062622788592, 3781.9432708509394, 3844.6732027777953, 3870.051837299823, 3875.147467557133, 3966.1076257842333, 1190.4404929683035, 1193.5285562203055, 1200.4357951762659, 1202.4288462980014, 1204.8975837053774, 770.2374649097353, 774.5004472115454, 807.0517142357706, 808.454293351985, 817.8854960305562, 5385.272988146628, 5389.7035663038905, 5426.294581704432, 5498.972505137449, 5503.422140675171, 563.490041512432, 571.8884817460638, 589.8790747896757, 913.0093848174805, 935.6912218967724, 3122.3911337289464, 3587.0494319005484, 3711.1278849470355, 3777.395616701315, 3812.942805857914, 9583.952080239555, 9828.901710982942, 9859.605615775288, 9871.309008369346, 9929.453880036668, 9892.307538472238, 9907.256955728206, 9915.405075695482, 9915.454649994175, 9933.850992235122, 7275.563466192046, 7663.501872378278, 7665.846683066419, 7791.649375778104, 7797.7660670179985, 5558.833235002957, 5637.915431268452, 5713.200151978644, 5716.0, 5759.280089988752, 8797.516136612549, 8892.42199257072, 9024.052474490347, 9163.083691630784, 9179.586918588813, 9161.679341223025, 9278.0, 9329.813403731752, 9363.765905852135, 9396.154346108882, 7052.400545953651, 7274.454415918933, 7280.854382912206, 7281.417486601165, 7315.890261645973, 7763.14605393395, 7769.184235655401, 7806.375489960676, 7840.490368126054, 7863.0, 5760.769569217185, 7080.114985626797, 7156.964215178891, 7166.964165179141, 7180.856382872418, 6898.275681053417, 6952.617606031717, 7004.054452649031, 7057.047298614827, 7088.822779430556, 6285.340039295808, 6306.306306306211, 6343.238811342669, 6417.1657684500715, 6444.226692796894, 4198.097409057067, 4884.63365247615, 4943.233798761198, 4959.156943319716, 5056.089903817348, 4823.686460380064, 4862.808611889968, 4972.950270497248, 5030.5975521957425, 5115.283860259641], "value": 4339.777166815463, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.4046826580971, 357.9856805727771, 367.30212596067474, 372.76515795049113, 376.7306375941203, 4622.144903192911, 4992.528698294344, 5326.813561525342, 5347.304850369456, 5383.892322153564, 4992.425871024833, 5015.724135172564, 5083.771230294637, 5150.939624150342, 5282.788688452467, 3440.7935523868646, 3634.327649384859, 3654.4335627977707, 4115.567865374122, 4161.771102589364, 3587.4080776671817, 3631.94552081719, 3925.3513524319856, 4160.251154792136, 4165.229432554972, 3679.576848662398, 3984.0677122230522, 4039.6364327210545, 4077.612626800449, 4147.357159640261, 4060.472138621975, 4065.9186816263805, 4070.8398106539494, 4089.9795501022604, 4092.5907409258984, 3177.6345720242007, 3604.774376711904, 3618.294432585647, 3629.745917785756, 3632.6185750496347, 4499.955000450019, 4794.35276237707, 5034.798608055673, 5078.739960717482, 5148.742562871879, 4704.259424013103, 4725.149473094842, 4727.3854398927915, 4742.573168414825, 4755.2153894607345, 5132.204508301219, 5468.9335579562, 5473.507384335429, 5524.502794748451, 5530.972345138249, 3546.0, 3761.5018033229085, 4009.4386785850006, 4049.3521036634293, 4060.654844338235, 4441.689081764278, 5794.478496935296, 5796.449337312949, 5828.446297601806, 5870.6771127587535, 3396.541466901986, 3406.6933975942284, 3809.9522631276623, 3851.67260782831, 3867.7872717000837, 3173.6032995875516, 3459.567554055743, 3781.9243615127543, 3913.5108111486065, 3918.314294998364, 3870.2066076454257, 4205.243056249843, 4380.817179361555, 4528.660350473728, 4529.343245229489, 5537.667739935617, 5559.221708960748, 5591.051919051669, 5600.887982240332, 5602.38373778884, 1197.5150064224003, 1260.1619922751452, 1271.9760592722946, 1274.6813296675832, 1292.4700872642172, 810.3031393002013, 833.6998680475024, 834.5118105907991, 846.3229416466802, 869.665178906113, 3900.108447403007, 3952.881413557598, 4182.56083111275, 4631.3601247288725, 4637.39713837199, 4905.754712264444, 4929.433115191727, 5255.421903590602, 5351.491608297283, 5371.677699338053, 3726.912928759849, 4254.468191476066, 4627.768611569475, 4851.781669824866, 4872.78072486739, 2688.5295073362086, 2857.8425737576313, 2873.0, 2878.172360551065, 2885.7114288570974, 4934.851954441372, 5005.174146265898, 5416.783328666888, 5573.526250268692, 5606.0, 5307.3896501902, 5531.944680553143, 5626.97186514073, 5760.514888492486, 5831.0, 4957.925631115464, 4972.627052971042, 5858.179854820329, 5901.17383566301, 5910.704464776744, 5336.332958380202, 5570.629768989865, 5684.431556844283, 5704.401037890962, 5776.7400466979925, 4833.978763272954, 5108.402437806004, 5631.662100273997, 5656.60403771732, 5698.601097923106, 5052.964142350883, 5840.576160893182, 5866.50134738552, 5867.911981320369, 5930.0, 3567.3935430977317, 3802.676772474371, 3824.5713971628775, 3840.7531594017814, 3841.2893614681375, 5102.341738934787, 5381.089713151775, 5408.214250024919, 5730.5702072345575, 5737.196792448977, 5513.0, 5546.448633628576, 5565.387807341108, 5565.5825813063375, 5582.33012038558, 4035.878923632296, 4861.368022157097, 4937.913658995016, 5273.446288139843, 5575.358833734173, 4953.0589188054155, 5061.797528098835, 5472.480114389126, 5491.615586908878, 5510.9448905510435, 4990.80036798524, 5157.819476318311, 5368.892622147457, 5564.916526252028, 5578.748956297058, 5427.484388983198, 5437.5378092860965, 5455.536279416294, 5474.727987884983, 5475.808346707846], "value": 4007.32192817167, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [719.6329871765399, 731.4477569435076, 743.3941337809688, 785.2736218997426, 846.1749793950896, 14121.788173177398, 14941.17823519706, 14987.100773953543, 14988.475403360884, 15005.324760385794, 14502.274886255671, 14728.6317842054, 14732.484363047295, 14745.0, 14747.92626036871, 687.4809518813314, 706.2407911495163, 873.8558137907238, 875.426595579893, 886.171429713217, 879.6877108626442, 882.9337799665019, 887.436477836572, 896.2874514760781, 897.9146981036791, 939.910708482693, 940.5673390240497, 941.6986564299427, 944.3436811416069, 948.037741692183, 737.4911311195258, 935.060264434246, 935.5743136872707, 938.5776400619749, 938.8873335199786, 561.404910794555, 563.7998510528786, 566.009483404043, 567.4382361462123, 569.1093438768314, 14424.711505769827, 14904.850951490454, 14906.552803415914, 14950.252487375588, 14967.775483367759, 10694.411807350592, 14121.15273083608, 14168.433262669481, 14200.786988195185, 14204.786928196085, 12824.935875320656, 12993.0, 13034.283114428703, 13162.868371316355, 13532.93233533826, 4415.867523974286, 4436.3123715824095, 4450.465944086698, 4450.4881938577155, 4511.097780443924, 108134.0, 108269.50382977046, 108583.91416085817, 109179.0, 111723.0, 11100.888991110147, 11149.832752508719, 11158.66096068477, 11219.831702524469, 11595.826062609067, 22610.321690349316, 22641.547169056856, 22758.08967641309, 22868.542629147658, 22954.0, 7292.0, 7566.444893842176, 7818.179091195342, 7856.489328193649, 8061.758147255592, 4210.221109094766, 4229.6404805591255, 4252.468441444819, 4312.05134870328, 4392.846250381285, 3447.1382154461385, 3459.308138372285, 3526.8941931741574, 3543.8228088595465, 3836.3478208704587, 700.7232143303366, 701.0115736811072, 703.085988215318, 718.4660749300177, 719.0688058963655, 532.2043544900322, 658.9670516474157, 677.5392732941647, 698.5250029979662, 712.3873468816813, 9750.463724495221, 10301.9484902575, 10487.842682359771, 10499.552944819952, 10571.682849514527, 680.3604611665019, 691.1257259566652, 700.8353037036293, 720.1861896057421, 729.5002922997763, 4889.0, 4897.804087836518, 4926.852194434173, 4927.95072049282, 4929.285253638274, 68829.0, 86117.0, 91301.08698912925, 92273.53863230642, 92594.61108083384, 76089.33687320918, 82589.58705206435, 82974.17025829664, 85895.0, 86884.0, 55495.72252138794, 69110.0, 69154.3084569158, 76943.0, 80384.5980770104, 9090.0, 10559.63041293551, 10628.309159904582, 10744.979226973424, 11189.104871610089, 47612.809679758284, 47629.761851190524, 47772.044559109316, 50912.49087509078, 51449.48550514447, 63831.680841595495, 65551.44485551407, 69927.65036174786, 70272.0, 70452.29547704458, 12975.351232438152, 13068.8039679403, 13150.671233219246, 13224.669383265495, 13517.526886558922, 14594.416223350947, 14640.474610437357, 14808.037477563925, 15115.31981060877, 15481.071135731892, 13665.350744002557, 13670.11144275619, 13774.0, 13791.310434478437, 14190.858091418953, 13538.187708737507, 13648.317584120556, 13683.452661893412, 13882.305884705926, 13905.791413128609, 13127.606171814861, 13565.932170339085, 13614.0, 13717.519886803913, 14047.016708830284, 7646.923530764621, 11075.778484430428, 11594.942025290156, 11785.116116291483, 11859.16985810985, 10011.699649010541, 10608.946955265174, 10668.679939601825, 10785.029347358775, 10857.457127143769], "value": 7533.4070957159565, "unit": "score"}], "name": "dromaeo_css", "value": 7266.647680457685, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 116.0, 114.0, 114.0, 114.0, 115.0, 113.0, 114.0, 113.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 108.0, 107.0, 168.0, 111.0, 109.0, 111.0, 113.0, 149.0, 110.0], "value": 122.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 185.0, 185.0, 184.0, 184.0, 180.0, 183.0, 182.0, 183.0, 185.0], "value": 183.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 59.0, 59.0, 86.0, 62.0, 58.0, 59.0, 58.0, 77.0, 59.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 117.0, 95.0, 68.0, 70.0, 82.0, 67.0, 70.0, 84.0], "value": 82.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 84.0, 87.0, 85.0, 88.0, 84.0, 90.0, 86.0, 89.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 95.0, 97.0, 96.0, 95.0, 96.0, 96.0, 108.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 84.0, 85.0, 85.0, 86.0, 87.0, 87.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 52.0, 53.0, 55.0, 56.0, 56.0, 54.0, 54.0, 53.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 79.0, 73.0, 74.0, 72.0, 71.0, 72.0, 71.0, 74.0], "value": 72.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 87.0, 89.0, 87.0, 86.0, 86.0, 87.0, 88.0, 85.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 139.0, 137.0, 137.0, 142.0, 143.0, 154.0, 212.0, 154.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 175.0, 173.0, 172.0, 173.0, 172.0, 172.0, 175.0, 175.0, 171.0], "value": 173.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 67.0, 68.0, 68.0, 67.0, 69.0, 66.0, 67.0], "value": 67.4, "unit": "score"}], "name": "kraken", "value": 1441.5, "alertThreshold": 2.0}]} 06:06:34 INFO - Return code: 0 06:06:34 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:06:34 ERROR - # TBPL SUCCESS # 06:06:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:06:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:06:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:06:34 INFO - 2017-01-25 06:06:34.428 screenresolution[1657:9844] starting screenresolution argv=screenresolution get 06:06:34 INFO - 2017-01-25 06:06:34.430 screenresolution[1657:9844] Display 0: 1600x1200x32@60 06:06:34 INFO - 2017-01-25 06:06:34.437 screenresolution[1658:9847] starting screenresolution argv=screenresolution list 06:06:34 INFO - Available Modes on Display 0 06:06:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:06:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:06:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:06:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:06:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:06:34 INFO - Intel Iris: 06:06:34 INFO - Chipset Model: Intel Iris 06:06:34 INFO - Type: GPU 06:06:34 INFO - Bus: Built-In 06:06:34 INFO - VRAM (Dynamic, Max): 1536 MB 06:06:34 INFO - Vendor: Intel (0x8086) 06:06:34 INFO - Device ID: 0x0a2e 06:06:34 INFO - Revision ID: 0x0009 06:06:34 INFO - Displays: 06:06:34 INFO - Display: 06:06:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:06:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:06:34 INFO - Display Serial Number: 1600x1200 60 06:06:34 INFO - Main Display: Yes 06:06:34 INFO - Mirror: Off 06:06:34 INFO - Online: Yes 06:06:34 INFO - Rotation: Supported 06:06:34 INFO - Return code: 0 06:06:34 INFO - Running post-action listener: _resource_record_post_action 06:06:34 INFO - [mozharness: 2017-01-25 14:06:34.677059Z] Finished run-tests step (success) 06:06:34 INFO - Running post-run listener: _resource_record_post_run 06:06:34 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 39048192; Write bytes: 551703040; Read time: 380; Write time: 1659 06:06:34 INFO - TinderboxPrint: CPU usage
53.7% 06:06:34 INFO - TinderboxPrint: I/O read bytes / time
39,048,192 / 380 06:06:34 INFO - TinderboxPrint: I/O write bytes / time
551,703,040 / 1,659 06:06:34 INFO - TinderboxPrint: CPU idle
2,222.9 (46.3%) 06:06:34 INFO - TinderboxPrint: CPU system
958.0 (20.0%) 06:06:34 INFO - TinderboxPrint: CPU user
1,620.9 (33.8%) 06:06:34 INFO - TinderboxPrint: Swap in / out
289,517,568 / 0 06:06:34 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 252125696; Write bytes: 251883520; Read time: 18038; Write time: 484 06:06:34 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 34649088; Write bytes: 296668160; Read time: 347; Write time: 1130 06:06:35 INFO - Running post-run listener: _upload_blobber_files 06:06:35 INFO - Blob upload gear active. 06:06:35 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:06:35 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:06:35 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:06:35 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:06:35 INFO - (blobuploader) - INFO - Open directory for files ... 06:06:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:06:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:06:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:36 INFO - (blobuploader) - INFO - Done attempting. 06:06:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:06:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:06:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:38 INFO - (blobuploader) - INFO - Done attempting. 06:06:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:06:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:06:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:39 INFO - (blobuploader) - INFO - Done attempting. 06:06:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:06:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:06:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:06:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:06:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:06:41 INFO - (blobuploader) - INFO - Done attempting. 06:06:41 INFO - (blobuploader) - INFO - Iteration through files over. 06:06:41 INFO - Return code: 0 06:06:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:06:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:06:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78be8fd3496f36b226920d0d1e4dc4c34ede3fdbdd53b4495cc53d5f88eddde417af274fe6b688356f7dfbc385d543da79e15abc20384580941b5ad5a3f290be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed999b10631ca47d33ebf5b575f220f60ed9726e10c9fb0766cb6e7366eb8a9c552ed32fc3839b6418cfde4a724f4342eeeefb6b648bda1648a20bd8966ed3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/755ad1462cca99cb9a84b5b9df20ac7f76a2cdbb0aae7b8e7e813d941081d32a5e6e6d1e2733e142d5c3273f34e6c63d0b41f5aa24a8169420663aedba9ce331", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c23af05e1ed5680584d0fdcd211757a42a083d9f8f663583f1f52e006d047505c0d50abe81b9256cd2dcd9eeaeb21c5702f4dd0007bee989af64bb94a1a5cfc"} 06:06:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:06:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:06:41 INFO - Contents: 06:06:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78be8fd3496f36b226920d0d1e4dc4c34ede3fdbdd53b4495cc53d5f88eddde417af274fe6b688356f7dfbc385d543da79e15abc20384580941b5ad5a3f290be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed999b10631ca47d33ebf5b575f220f60ed9726e10c9fb0766cb6e7366eb8a9c552ed32fc3839b6418cfde4a724f4342eeeefb6b648bda1648a20bd8966ed3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/755ad1462cca99cb9a84b5b9df20ac7f76a2cdbb0aae7b8e7e813d941081d32a5e6e6d1e2733e142d5c3273f34e6c63d0b41f5aa24a8169420663aedba9ce331", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c23af05e1ed5680584d0fdcd211757a42a083d9f8f663583f1f52e006d047505c0d50abe81b9256cd2dcd9eeaeb21c5702f4dd0007bee989af64bb94a1a5cfc"} 06:06:41 INFO - Running post-run listener: copy_logs_to_upload_dir 06:06:41 INFO - Copying logs to upload dir... 06:06:41 INFO - mkdir: /builds/slave/test/build/upload/logs 06:06:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.223307 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-25 06:06:41.899276) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:41.902744) ========= 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.vebn4jyhBf/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.fuVqlEr41h/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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/78be8fd3496f36b226920d0d1e4dc4c34ede3fdbdd53b4495cc53d5f88eddde417af274fe6b688356f7dfbc385d543da79e15abc20384580941b5ad5a3f290be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed999b10631ca47d33ebf5b575f220f60ed9726e10c9fb0766cb6e7366eb8a9c552ed32fc3839b6418cfde4a724f4342eeeefb6b648bda1648a20bd8966ed3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/755ad1462cca99cb9a84b5b9df20ac7f76a2cdbb0aae7b8e7e813d941081d32a5e6e6d1e2733e142d5c3273f34e6c63d0b41f5aa24a8169420663aedba9ce331", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c23af05e1ed5680584d0fdcd211757a42a083d9f8f663583f1f52e006d047505c0d50abe81b9256cd2dcd9eeaeb21c5702f4dd0007bee989af64bb94a1a5cfc"} build_url:https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010927 build_url: 'https://queue.taskcluster.net/v1/task/M1jEidPYRCy8lGiunCKqeQ/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/78be8fd3496f36b226920d0d1e4dc4c34ede3fdbdd53b4495cc53d5f88eddde417af274fe6b688356f7dfbc385d543da79e15abc20384580941b5ad5a3f290be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3ed999b10631ca47d33ebf5b575f220f60ed9726e10c9fb0766cb6e7366eb8a9c552ed32fc3839b6418cfde4a724f4342eeeefb6b648bda1648a20bd8966ed3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/755ad1462cca99cb9a84b5b9df20ac7f76a2cdbb0aae7b8e7e813d941081d32a5e6e6d1e2733e142d5c3273f34e6c63d0b41f5aa24a8169420663aedba9ce331", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2c23af05e1ed5680584d0fdcd211757a42a083d9f8f663583f1f52e006d047505c0d50abe81b9256cd2dcd9eeaeb21c5702f4dd0007bee989af64bb94a1a5cfc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:41.937663) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:41.938035) ========= 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.vebn4jyhBf/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.fuVqlEr41h/Listeners TMPDIR=/var/folders/kg/2ls1v8cn01s24rdksn7m4cqw00000w/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.005061 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-25 06:06:41.987874) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 06:06:41.988291) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-25 06:06:41.988726) ========= ========= Total master_lag: 0.18 =========