builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0088 starttime: 1490280340.37 results: success (0) buildid: 20170323054523 builduid: b48900d6467042bda4b0f3ad4a2f5dde revision: 2e95b7e18fcf2b24844e484776c050e0d0c51e70 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:40.372740) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:40.373164) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:40.373534) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:40.399746) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:40.400146) ========= 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.HzYYRkaVTR/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.GNBK3eSghX/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-23 07:45:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 13.7M=0.001s 2017-03-23 07:45:40 (13.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.141626 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:40.663857) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:40.664172) ========= 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.HzYYRkaVTR/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.GNBK3eSghX/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.029266 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:40.715632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 07:45:40.715986) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2e95b7e18fcf2b24844e484776c050e0d0c51e70 --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 2e95b7e18fcf2b24844e484776c050e0d0c51e70 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HzYYRkaVTR/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.GNBK3eSghX/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-23 07:45:40,802 truncating revision to first 12 chars 2017-03-23 07:45:40,802 Setting DEBUG logging. 2017-03-23 07:45:40,802 attempt 1/10 2017-03-23 07:45:40,802 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2e95b7e18fcf?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 07:45:41,897 unpacking tar archive at: mozilla-central-2e95b7e18fcf/testing/mozharness/ program finished with exit code 0 elapsedTime=1.372484 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 07:45:42.111922) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:42.112275) ========= script_repo_revision: 2e95b7e18fcf2b24844e484776c050e0d0c51e70 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:42.112741) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:42.113078) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 07:45:42.133539) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-03-23 07:45:42.133933) ========= /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.HzYYRkaVTR/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.GNBK3eSghX/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:45:42 INFO - MultiFileLogger online at 20170323 07:45:42 in /builds/slave/test 07:45:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 07:45:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:45:42 INFO - {'append_to_log': False, 07:45:42 INFO - 'base_work_dir': '/builds/slave/test', 07:45:42 INFO - 'blob_upload_branch': 'Firefox', 07:45:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:45:42 INFO - 'branch': 'Firefox', 07:45:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:45:42 INFO - 'config_files': ('talos/mac_config.py',), 07:45:42 INFO - 'default_actions': ('clobber', 07:45:42 INFO - 'read-buildbot-config', 07:45:42 INFO - 'download-and-extract', 07:45:42 INFO - 'populate-webroot', 07:45:42 INFO - 'create-virtualenv', 07:45:42 INFO - 'install', 07:45:42 INFO - 'run-tests'), 07:45:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:45:42 INFO - 'download_minidump_stackwalk': True, 07:45:42 INFO - 'download_symbols': 'ondemand', 07:45:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:45:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:45:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:45:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:45:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:45:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:45:42 INFO - 'gecko_profile': False, 07:45:42 INFO - 'gecko_profile_interval': 0, 07:45:42 INFO - 'installer_path': 'installer.exe', 07:45:42 INFO - 'log_level': 'info', 07:45:42 INFO - 'log_name': 'talos', 07:45:42 INFO - 'log_to_console': True, 07:45:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:45:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:45:42 INFO - 'opt_config_files': (), 07:45:42 INFO - 'pip_index': False, 07:45:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:42 INFO - 'cmd': ('bash', 07:45:42 INFO - '-c', 07:45:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:42 INFO - 'enabled': True, 07:45:42 INFO - 'halt_on_failure': False, 07:45:42 INFO - 'name': 'check_screen_resolution'},), 07:45:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:45:42 INFO - 'cmd': ('bash', 07:45:42 INFO - '-c', 07:45:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:45:42 INFO - 'enabled': True, 07:45:42 INFO - 'halt_on_failure': False, 07:45:42 INFO - 'name': 'check_screen_resolution'},), 07:45:42 INFO - 'run_cmd_checks_enabled': True, 07:45:42 INFO - 'suite': 'dromaeojs', 07:45:42 INFO - 'system_bits': '32', 07:45:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:45:42 INFO - 'title': 't-yosemite-r7-0088', 07:45:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:45:42 INFO - 'use_talos_json': True, 07:45:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:45:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:45:42 INFO - 'work_dir': 'build'} 07:45:42 INFO - [mozharness: 2017-03-23 14:45:42.339864Z] Running clobber step. 07:45:42 INFO - Running pre-action listener: _resource_record_pre_action 07:45:42 INFO - Running main action method: clobber 07:45:42 INFO - rmtree: /builds/slave/test/build 07:45:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:45:46 INFO - Running post-action listener: _resource_record_post_action 07:45:46 INFO - [mozharness: 2017-03-23 14:45:46.924233Z] Finished clobber step (success) 07:45:46 INFO - [mozharness: 2017-03-23 14:45:46.924390Z] Running read-buildbot-config step. 07:45:46 INFO - Running pre-action listener: _resource_record_pre_action 07:45:46 INFO - Running main action method: read_buildbot_config 07:45:46 INFO - Using buildbot properties: 07:45:46 INFO - { 07:45:46 INFO - "project": "", 07:45:46 INFO - "product": "firefox", 07:45:46 INFO - "script_repo_revision": "production", 07:45:46 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:45:46 INFO - "repository": "", 07:45:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:45:46 INFO - "buildid": "20170323054523", 07:45:46 INFO - "pgo_build": "False", 07:45:46 INFO - "basedir": "/builds/slave/test", 07:45:46 INFO - "buildnumber": 33, 07:45:46 INFO - "slavename": "t-yosemite-r7-0088", 07:45:46 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 07:45:46 INFO - "platform": "yosemite_r7", 07:45:46 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:45:46 INFO - "branch": "mozilla-central", 07:45:46 INFO - "repo_path": "mozilla-central", 07:45:46 INFO - "revision": "2e95b7e18fcf2b24844e484776c050e0d0c51e70", 07:45:46 INFO - "stage_platform": "macosx64", 07:45:46 INFO - "builduid": "b48900d6467042bda4b0f3ad4a2f5dde", 07:45:46 INFO - "slavebuilddir": "test" 07:45:46 INFO - } 07:45:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 07:45:46 INFO - Running post-action listener: _resource_record_post_action 07:45:46 INFO - [mozharness: 2017-03-23 14:45:46.927315Z] Finished read-buildbot-config step (success) 07:45:46 INFO - [mozharness: 2017-03-23 14:45:46.927425Z] Running download-and-extract step. 07:45:46 INFO - Running pre-action listener: _resource_record_pre_action 07:45:46 INFO - Running main action method: download_and_extract 07:45:46 INFO - mkdir: /builds/slave/test/build/tests 07:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:45:46 INFO - trying https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 07:45:46 INFO - Downloading https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 07:45:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 07:45:48 INFO - Downloaded 1325 bytes. 07:45:48 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 07:45:48 INFO - Using the following test package requirements: 07:45:48 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:48 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 07:45:48 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:45:48 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:48 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 07:45:48 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:48 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 07:45:48 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:48 INFO - u'jsshell-mac.zip'], 07:45:48 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:48 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 07:45:48 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:45:48 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:48 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 07:45:48 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:48 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 07:45:48 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:48 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 07:45:48 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:45:48 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 07:45:48 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:45:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:45:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:45:48 INFO - Fetch https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:45:49 INFO - Expected file size: 52406594 07:45:49 INFO - Obtained file size: 52406594 07:46:06 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 07:46:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:46:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:46:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:46:07 INFO - Expected file size: 52406594 07:46:07 INFO - Obtained file size: 52406594 07:46:23 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 07:46:23 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:46:23 INFO - Fetch https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 07:46:24 INFO - Expected file size: 14404171 07:46:24 INFO - Obtained file size: 14404171 07:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:24 INFO - trying https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:46:24 INFO - Downloading https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 07:46:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 07:46:26 INFO - Downloaded 75442016 bytes. 07:46:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:46:26 INFO - mkdir: /builds/slave/test/properties 07:46:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:46:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:46:26 INFO - Contents: 07:46:26 INFO - build_url:https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:46:27 INFO - Running post-action listener: _resource_record_post_action 07:46:27 INFO - Running post-action listener: set_extra_try_arguments 07:46:27 INFO - [mozharness: 2017-03-23 14:46:27.217412Z] Finished download-and-extract step (success) 07:46:27 INFO - [mozharness: 2017-03-23 14:46:27.217537Z] Running populate-webroot step. 07:46:27 INFO - Running pre-action listener: _resource_record_pre_action 07:46:27 INFO - Running main action method: populate_webroot 07:46:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:46:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:46:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:46:27 INFO - '--tppagecycles', 07:46:27 INFO - '7'], 07:46:27 INFO - 'tests': ['tsvgm']}}, 07:46:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:46:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:46:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:46:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:46:27 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:46:27 INFO - 'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:27 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:46:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:46:27 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:46:27 INFO - 'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['damp', 'tps']}, 07:46:27 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:46:27 INFO - 'tests': ['damp', 'tps']}, 07:46:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['dromaeo_dom']}, 07:46:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:46:27 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['basic_compositor_video']}, 07:46:27 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:46:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['a11yr', 07:46:27 INFO - 'ts_paint', 07:46:27 INFO - 'tpaint', 07:46:27 INFO - 'sessionrestore', 07:46:27 INFO - 'sessionrestore_no_auto_restore', 07:46:27 INFO - 'tabpaint']}, 07:46:27 INFO - 'other-e10s': {'tests': ['a11yr', 07:46:27 INFO - 'ts_paint', 07:46:27 INFO - 'tpaint', 07:46:27 INFO - 'sessionrestore', 07:46:27 INFO - 'sessionrestore_no_auto_restore', 07:46:27 INFO - 'tabpaint']}, 07:46:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:46:27 INFO - 'ts_paint', 07:46:27 INFO - 'tpaint', 07:46:27 INFO - 'sessionrestore', 07:46:27 INFO - 'sessionrestore_no_auto_restore', 07:46:27 INFO - 'tabpaint']}, 07:46:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:46:27 INFO - 'ts_paint', 07:46:27 INFO - 'tpaint', 07:46:27 INFO - 'sessionrestore', 07:46:27 INFO - 'sessionrestore_no_auto_restore', 07:46:27 INFO - 'tabpaint']}, 07:46:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['a11yr', 07:46:27 INFO - 'ts_paint', 07:46:27 INFO - 'tpaint', 07:46:27 INFO - 'sessionrestore', 07:46:27 INFO - 'sessionrestore_no_auto_restore', 07:46:27 INFO - 'tabpaint']}, 07:46:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['a11yr', 07:46:27 INFO - 'ts_paint', 07:46:27 INFO - 'tpaint', 07:46:27 INFO - 'sessionrestore', 07:46:27 INFO - 'sessionrestore_no_auto_restore', 07:46:27 INFO - 'tabpaint']}, 07:46:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['tsvgx', 07:46:27 INFO - 'tsvgr_opacity', 07:46:27 INFO - 'tart', 07:46:27 INFO - 'tscrollx', 07:46:27 INFO - 'cart', 07:46:27 INFO - 'tsvg_static']}, 07:46:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:46:27 INFO - 'tsvgr_opacity', 07:46:27 INFO - 'tart', 07:46:27 INFO - 'tscrollx', 07:46:27 INFO - 'cart', 07:46:27 INFO - 'tsvg_static']}, 07:46:27 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:46:27 INFO - 'talos_options': ['--disable-e10s'], 07:46:27 INFO - 'tests': ['tp5o']}, 07:46:27 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:46:27 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:46:27 INFO - 'talos_options': ['--disable-e10s', 07:46:27 INFO - '--xperf_path', 07:46:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:27 INFO - 'tests': ['tp5n']}, 07:46:27 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:46:27 INFO - 'talos_options': ['--xperf_path', 07:46:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:46:27 INFO - 'tests': ['tp5n']}}, 07:46:27 INFO - 'talos.zip': {'path': '', 07:46:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:46:27 INFO - Running post-action listener: _resource_record_post_action 07:46:27 INFO - [mozharness: 2017-03-23 14:46:27.236410Z] Finished populate-webroot step (success) 07:46:27 INFO - [mozharness: 2017-03-23 14:46:27.236560Z] Running create-virtualenv step. 07:46:27 INFO - Running pre-action listener: _resource_record_pre_action 07:46:27 INFO - Running main action method: create_virtualenv 07:46:27 INFO - Creating virtualenv /builds/slave/test/build/venv 07:46:27 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:46:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:46:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:46:27 INFO - Using real prefix '/tools/python27' 07:46:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:46:28 INFO - Installing distribute.............................................................................................................................................................................................done. 07:46:31 INFO - Installing pip.................done. 07:46:31 INFO - Return code: 0 07:46:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:46:31 INFO - Reading from file tmpfile_stdout 07:46:31 INFO - Output received: 07:46:31 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 07:46:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07: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')]} 07:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:46:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:46:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:31 INFO - 'HOME': '/Users/cltbld', 07:46:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:31 INFO - 'LOGNAME': 'cltbld', 07:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:31 INFO - 'MOZ_NO_REMOTE': '1', 07:46:31 INFO - 'NO_EM_RESTART': '1', 07:46:31 INFO - 'PAGER': '/bin/cat', 07:46:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:31 INFO - 'PWD': '/builds/slave/test', 07:46:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:31 INFO - 'SHELL': '/bin/bash', 07:46:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:46:31 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:46:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:31 INFO - 'USER': 'cltbld', 07:46:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:31 INFO - 'XPC_FLAGS': '0x0', 07:46:31 INFO - 'XPC_SERVICE_NAME': '0', 07:46:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:46:31 INFO - Cleaning up... 07:46:31 INFO - Return code: 0 07:46:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07: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')]} 07:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07: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')]} 07:46:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:46:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:46:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:46:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:31 INFO - 'HOME': '/Users/cltbld', 07:46:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:31 INFO - 'LOGNAME': 'cltbld', 07:46:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:31 INFO - 'MOZ_NO_REMOTE': '1', 07:46:31 INFO - 'NO_EM_RESTART': '1', 07:46:31 INFO - 'PAGER': '/bin/cat', 07:46:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:31 INFO - 'PWD': '/builds/slave/test', 07:46:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:31 INFO - 'SHELL': '/bin/bash', 07:46:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:46:31 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:46:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:31 INFO - 'USER': 'cltbld', 07:46:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:31 INFO - 'XPC_FLAGS': '0x0', 07:46:31 INFO - 'XPC_SERVICE_NAME': '0', 07:46:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:31 INFO - Downloading/unpacking psutil>=3.1.1 07:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:46:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:35 INFO - Installing collected packages: psutil 07:46:35 INFO - Running setup.py install for psutil 07:46:35 INFO - building 'psutil._psutil_osx' extension 07:46:35 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:46:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:46:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:46:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:46:36 INFO - building 'psutil._psutil_posix' extension 07:46:36 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:46:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:46:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:46:36 INFO - ^ 07:46:36 INFO - 1 warning generated. 07:46:36 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:46:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:46:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:46:36 INFO - Successfully installed psutil 07:46:36 INFO - Cleaning up... 07:46:36 INFO - Return code: 0 07:46:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:46:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:37 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 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:46:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:46:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:46:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:37 INFO - 'HOME': '/Users/cltbld', 07:46:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:37 INFO - 'LOGNAME': 'cltbld', 07:46:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:37 INFO - 'MOZ_NO_REMOTE': '1', 07:46:37 INFO - 'NO_EM_RESTART': '1', 07:46:37 INFO - 'PAGER': '/bin/cat', 07:46:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:37 INFO - 'PWD': '/builds/slave/test', 07:46:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:37 INFO - 'SHELL': '/bin/bash', 07:46:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:46:37 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:46:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:37 INFO - 'USER': 'cltbld', 07:46:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:37 INFO - 'XPC_FLAGS': '0x0', 07:46:37 INFO - 'XPC_SERVICE_NAME': '0', 07:46:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:37 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:46:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:46:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:46:40 INFO - Installing collected packages: mozsystemmonitor 07:46:40 INFO - Running setup.py install for mozsystemmonitor 07:46:40 INFO - Successfully installed mozsystemmonitor 07:46:40 INFO - Cleaning up... 07:46:40 INFO - Return code: 0 07:46:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:41 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 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:46:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:46:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:46:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:41 INFO - 'HOME': '/Users/cltbld', 07:46:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:41 INFO - 'LOGNAME': 'cltbld', 07:46:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:41 INFO - 'MOZ_NO_REMOTE': '1', 07:46:41 INFO - 'NO_EM_RESTART': '1', 07:46:41 INFO - 'PAGER': '/bin/cat', 07:46:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:41 INFO - 'PWD': '/builds/slave/test', 07:46:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:41 INFO - 'SHELL': '/bin/bash', 07:46:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:46:41 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:46:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:41 INFO - 'USER': 'cltbld', 07:46:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:41 INFO - 'XPC_FLAGS': '0x0', 07:46:41 INFO - 'XPC_SERVICE_NAME': '0', 07:46:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:41 INFO - Downloading/unpacking jsonschema==2.5.1 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:46:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:44 INFO - Downloading functools32-3.2.3-2.tar.gz 07:46:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:46:44 INFO - warning: no files found matching '*.txt' 07:46:44 INFO - no previously-included directories found matching 'build' 07:46:44 INFO - no previously-included directories found matching 'dist' 07:46:44 INFO - no previously-included directories found matching '.git*' 07:46:44 INFO - Installing collected packages: jsonschema, functools32 07:46:44 INFO - Running setup.py install for functools32 07:46:44 INFO - warning: no files found matching '*.txt' 07:46:44 INFO - no previously-included directories found matching 'build' 07:46:44 INFO - no previously-included directories found matching 'dist' 07:46:44 INFO - no previously-included directories found matching '.git*' 07:46:44 INFO - Successfully installed jsonschema functools32 07:46:44 INFO - Cleaning up... 07:46:44 INFO - Return code: 0 07:46:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:44 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 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:44 INFO - 'HOME': '/Users/cltbld', 07:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:44 INFO - 'LOGNAME': 'cltbld', 07:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:44 INFO - 'MOZ_NO_REMOTE': '1', 07:46:44 INFO - 'NO_EM_RESTART': '1', 07:46:44 INFO - 'PAGER': '/bin/cat', 07:46:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:44 INFO - 'PWD': '/builds/slave/test', 07:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:44 INFO - 'SHELL': '/bin/bash', 07:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:46:44 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:44 INFO - 'USER': 'cltbld', 07:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:44 INFO - 'XPC_FLAGS': '0x0', 07:46:44 INFO - 'XPC_SERVICE_NAME': '0', 07:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:46:44 INFO - Cleaning up... 07:46:44 INFO - Return code: 0 07:46:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:44 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 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:46:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:46:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:46:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:44 INFO - 'HOME': '/Users/cltbld', 07:46:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:44 INFO - 'LOGNAME': 'cltbld', 07:46:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:44 INFO - 'MOZ_NO_REMOTE': '1', 07:46:44 INFO - 'NO_EM_RESTART': '1', 07:46:44 INFO - 'PAGER': '/bin/cat', 07:46:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:44 INFO - 'PWD': '/builds/slave/test', 07:46:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:44 INFO - 'SHELL': '/bin/bash', 07:46:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:46:44 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:46:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:44 INFO - 'USER': 'cltbld', 07:46:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:44 INFO - 'XPC_FLAGS': '0x0', 07:46:44 INFO - 'XPC_SERVICE_NAME': '0', 07:46:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:45 INFO - Downloading/unpacking blobuploader==1.2.4 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:47 INFO - Downloading blobuploader-1.2.4.tar.gz 07:46:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:46:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:46:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:49 INFO - Downloading docopt-0.6.1.tar.gz 07:46:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:46:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:46:49 INFO - Running setup.py install for blobuploader 07:46:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:46:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:46:49 INFO - Running setup.py install for requests 07:46:49 INFO - Running setup.py install for docopt 07:46:49 INFO - Successfully installed blobuploader requests docopt 07:46:49 INFO - Cleaning up... 07:46:50 INFO - Return code: 0 07:46:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:50 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 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:50 INFO - 'HOME': '/Users/cltbld', 07:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:50 INFO - 'LOGNAME': 'cltbld', 07:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:50 INFO - 'MOZ_NO_REMOTE': '1', 07:46:50 INFO - 'NO_EM_RESTART': '1', 07:46:50 INFO - 'PAGER': '/bin/cat', 07:46:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:50 INFO - 'PWD': '/builds/slave/test', 07:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:50 INFO - 'SHELL': '/bin/bash', 07:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:46:50 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:50 INFO - 'USER': 'cltbld', 07:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:50 INFO - 'XPC_FLAGS': '0x0', 07:46:50 INFO - 'XPC_SERVICE_NAME': '0', 07:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:50 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Tg2fII-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:50 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-11ksqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:50 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-TZlmbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:50 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Tg86w_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:50 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-S4elZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:50 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-agnbwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:50 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-ONoWga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-M5ISsr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Ei6HIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-bP7fKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-pC8e0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-2vLw4Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-XdlSfh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-t9UOH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-g0ELVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JRvxSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:51 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Spbsqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:46:52 INFO - Running setup.py install for manifestparser 07:46:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:46:52 INFO - Running setup.py install for mozcrash 07:46:52 INFO - Running setup.py install for mozdebug 07:46:52 INFO - Running setup.py install for mozdevice 07:46:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:46:52 INFO - Running setup.py install for mozfile 07:46:52 INFO - Running setup.py install for mozhttpd 07:46:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:46:52 INFO - Running setup.py install for mozinfo 07:46:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for mozInstall 07:46:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for mozleak 07:46:53 INFO - Running setup.py install for mozlog 07:46:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for moznetwork 07:46:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for mozprocess 07:46:53 INFO - Running setup.py install for mozprofile 07:46:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:46:53 INFO - Running setup.py install for mozrunner 07:46:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Running setup.py install for mozscreenshot 07:46:54 INFO - Running setup.py install for moztest 07:46:54 INFO - Running setup.py install for mozversion 07:46:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:46:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:46:54 INFO - Cleaning up... 07:46:54 INFO - Return code: 0 07:46:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:46:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:46:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:46:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:46:54 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 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:46:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:46:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:46:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:46:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:46:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:46:54 INFO - 'HOME': '/Users/cltbld', 07:46:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:46:54 INFO - 'LOGNAME': 'cltbld', 07:46:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:46:54 INFO - 'MOZ_NO_REMOTE': '1', 07:46:54 INFO - 'NO_EM_RESTART': '1', 07:46:54 INFO - 'PAGER': '/bin/cat', 07:46:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:46:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:46:54 INFO - 'PWD': '/builds/slave/test', 07:46:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:46:54 INFO - 'SHELL': '/bin/bash', 07:46:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:46:54 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:46:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:46:54 INFO - 'USER': 'cltbld', 07:46:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:46:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:46:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:46:54 INFO - 'XPC_FLAGS': '0x0', 07:46:54 INFO - 'XPC_SERVICE_NAME': '0', 07:46:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:46:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:46:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:46:54 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-_n9KLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-XMjD2a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-_OYBRg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-hkd7BU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-mVZizA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-JDLOdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-cMSWd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-TsF_UT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-RwEuey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-qMsc4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:46:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:46:55 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-hhj0l_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:46:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-GqADu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:46:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-BnOYmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:46:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-13NAVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-WGWVTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:46:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-cuXlAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:46:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:46:56 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-4l766E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:46:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:46:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:46:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:46:59 INFO - Downloading blessings-1.6.tar.gz 07:46:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:46:59 INFO - Installing collected packages: blessings 07:46:59 INFO - Running setup.py install for blessings 07:46:59 INFO - Successfully installed blessings 07:46:59 INFO - Cleaning up... 07:46:59 INFO - Return code: 0 07:46:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:46:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:46:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:00 INFO - Reading from file tmpfile_stdout 07:47:00 INFO - Current package versions: 07:47:00 INFO - blessings == 1.6 07:47:00 INFO - blobuploader == 1.2.4 07:47:00 INFO - docopt == 0.6.1 07:47:00 INFO - functools32 == 3.2.3-2 07:47:00 INFO - jsonschema == 2.5.1 07:47:00 INFO - manifestparser == 1.1 07:47:00 INFO - mozInstall == 1.12 07:47:00 INFO - mozcrash == 1.0 07:47:00 INFO - mozdebug == 0.1 07:47:00 INFO - mozdevice == 0.49 07:47:00 INFO - mozfile == 1.2 07:47:00 INFO - mozhttpd == 0.7 07:47:00 INFO - mozinfo == 0.9 07:47:00 INFO - mozleak == 0.1 07:47:00 INFO - mozlog == 3.4 07:47:00 INFO - moznetwork == 0.27 07:47:00 INFO - mozprocess == 0.25 07:47:00 INFO - mozprofile == 0.28 07:47:00 INFO - mozrunner == 6.13 07:47:00 INFO - mozscreenshot == 0.1 07:47:00 INFO - mozsystemmonitor == 0.3 07:47:00 INFO - moztest == 0.8 07:47:00 INFO - mozversion == 1.4 07:47:00 INFO - psutil == 3.1.1 07:47:00 INFO - requests == 1.2.3 07:47:00 INFO - wsgiref == 0.1.2 07:47:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:00 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 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:47:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:47:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:00 INFO - 'HOME': '/Users/cltbld', 07:47:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:00 INFO - 'LOGNAME': 'cltbld', 07:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:00 INFO - 'MOZ_NO_REMOTE': '1', 07:47:00 INFO - 'NO_EM_RESTART': '1', 07:47:00 INFO - 'PAGER': '/bin/cat', 07:47:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:00 INFO - 'PWD': '/builds/slave/test', 07:47:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:00 INFO - 'SHELL': '/bin/bash', 07:47:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:47:00 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:47:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:00 INFO - 'USER': 'cltbld', 07:47:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:00 INFO - 'XPC_FLAGS': '0x0', 07:47:00 INFO - 'XPC_SERVICE_NAME': '0', 07:47:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:47:00 INFO - Cleaning up... 07:47:00 INFO - Return code: 0 07:47:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:47:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:47:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:47:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:47:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x103d8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103d8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd1db4a6f50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, '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.HzYYRkaVTR/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.GNBK3eSghX/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:47:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:47:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:47:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:00 INFO - 'HOME': '/Users/cltbld', 07:47:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:00 INFO - 'LOGNAME': 'cltbld', 07:47:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:00 INFO - 'MOZ_NO_REMOTE': '1', 07:47:00 INFO - 'NO_EM_RESTART': '1', 07:47:00 INFO - 'PAGER': '/bin/cat', 07:47:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:00 INFO - 'PWD': '/builds/slave/test', 07:47:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:00 INFO - 'SHELL': '/bin/bash', 07:47:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:47:00 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:47:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:00 INFO - 'USER': 'cltbld', 07:47:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:00 INFO - 'XPC_FLAGS': '0x0', 07:47:00 INFO - 'XPC_SERVICE_NAME': '0', 07:47:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:47:00 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:47:00 INFO - Cleaning up... 07:47:00 INFO - Return code: 0 07:47:00 INFO - Running post-action listener: _resource_record_post_action 07:47:00 INFO - Running post-action listener: _start_resource_monitoring 07:47:00 INFO - Starting resource monitoring. 07:47:00 INFO - [mozharness: 2017-03-23 14:47:00.592811Z] Finished create-virtualenv step (success) 07:47:00 INFO - [mozharness: 2017-03-23 14:47:00.593839Z] Running install step. 07:47:00 INFO - Running pre-action listener: _resource_record_pre_action 07:47:00 INFO - Running main action method: install 07:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:47:00 INFO - Reading from file tmpfile_stdout 07:47:00 INFO - Detecting whether we're running mozinstall >=1.0... 07:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:47:00 INFO - Reading from file tmpfile_stdout 07:47:00 INFO - Output received: 07:47:00 INFO - Usage: mozinstall [options] installer 07:47:00 INFO - Options: 07:47:00 INFO - -h, --help show this help message and exit 07:47:00 INFO - -d DEST, --destination=DEST 07:47:00 INFO - Directory to install application into. [default: 07:47:00 INFO - "/builds/slave/test"] 07:47:00 INFO - --app=APP Application being installed. [default: firefox] 07:47:00 INFO - mkdir: /builds/slave/test/build/application 07:47:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:47:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 07:47:21 INFO - Reading from file tmpfile_stdout 07:47:21 INFO - Output received: 07:47:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:47:21 INFO - Running post-action listener: _resource_record_post_action 07:47:21 INFO - [mozharness: 2017-03-23 14:47:21.540582Z] Finished install step (success) 07:47:21 INFO - [mozharness: 2017-03-23 14:47:21.540739Z] Running run-tests step. 07:47:21 INFO - Running pre-action listener: _resource_record_pre_action 07:47:21 INFO - Running main action method: run_tests 07:47:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:47:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:47:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:47:21 INFO - 2017-03-23 07:47:21.555 screenresolution[1618:7463] starting screenresolution argv=screenresolution get 07:47:21 INFO - 2017-03-23 07:47:21.557 screenresolution[1618:7463] Display 0: 1600x1200x32@60 07:47:21 INFO - 2017-03-23 07:47:21.563 screenresolution[1619:7465] starting screenresolution argv=screenresolution list 07:47:21 INFO - Available Modes on Display 0 07:47:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:47:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:47:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:47:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:47:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:47:21 INFO - Intel Iris: 07:47:21 INFO - Chipset Model: Intel Iris 07:47:21 INFO - Type: GPU 07:47:21 INFO - Bus: Built-In 07:47:21 INFO - VRAM (Dynamic, Max): 1536 MB 07:47:21 INFO - Vendor: Intel (0x8086) 07:47:21 INFO - Device ID: 0x0a2e 07:47:21 INFO - Revision ID: 0x0009 07:47:21 INFO - Displays: 07:47:21 INFO - Display: 07:47:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:47:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:47:21 INFO - Display Serial Number: 1600x1200 60 07:47:21 INFO - Main Display: Yes 07:47:21 INFO - Mirror: Off 07:47:21 INFO - Online: Yes 07:47:21 INFO - Rotation: Supported 07:47:21 INFO - Return code: 0 07:47:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:47:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:47:21 INFO - Python 2.7.3 07:47:21 INFO - Return code: 0 07:47:21 INFO - grabbing minidump binary from tooltool 07:47: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')]} 07:47:21 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 0x103b69d30>, '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 0x103a90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103b5ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:47:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:47:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:47:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:47:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:47:21 INFO - Return code: 0 07:47:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:47:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:47:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:47:21 INFO - ENV: RUST_BACKTRACE is now 1 07:47:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:47:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:47:21 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/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:47:21 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/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:47:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HzYYRkaVTR/Render', 07:47:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:47:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:47:21 INFO - 'HOME': '/Users/cltbld', 07:47:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:47:21 INFO - 'LOGNAME': 'cltbld', 07:47:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:47:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:47:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:47:21 INFO - 'MOZ_NO_REMOTE': '1', 07:47:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:47:21 INFO - 'NO_EM_RESTART': '1', 07:47:21 INFO - 'PAGER': '/bin/cat', 07:47:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:47:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:47:21 INFO - 'PWD': '/builds/slave/test', 07:47:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:47:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:47:21 INFO - 'RUST_BACKTRACE': '1', 07:47:21 INFO - 'SHELL': '/bin/bash', 07:47:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GNBK3eSghX/Listeners', 07:47:21 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 07:47:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:47:21 INFO - 'USER': 'cltbld', 07:47:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:47:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:47:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:47:21 INFO - 'XPC_FLAGS': '0x0', 07:47:21 INFO - 'XPC_SERVICE_NAME': '0', 07:47:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:47:21 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/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:47:22 INFO - mozversion application_buildid: 20170323054523 07:47:22 INFO - mozversion application_changeset: 2e95b7e18fcf2b24844e484776c050e0d0c51e70 07:47:22 INFO - mozversion application_display_name: Nightly 07:47:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:47:22 INFO - mozversion application_name: Firefox 07:47:22 INFO - mozversion application_remotingname: firefox 07:47:22 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:47:22 INFO - mozversion application_vendor: Mozilla 07:47:22 INFO - mozversion application_version: 55.0a1 07:47:22 INFO - mozversion platform_buildid: 20170323054523 07:47:22 INFO - mozversion platform_changeset: 2e95b7e18fcf2b24844e484776c050e0d0c51e70 07:47:22 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:47:22 INFO - mozversion platform_version: 55.0a1 07:47:22 INFO - using testdate: 1490280442 07:47:22 INFO - actual date: 1490280442 07:47:22 INFO - starting webserver on 'localhost:49245' 07:47:22 INFO - SUITE-START | Running 2 tests 07:47:22 INFO - TEST-START | dromaeo_css 07:47:22 INFO - operating with platform_type : mac_ 07:47:22 INFO - Initialising browser for dromaeo_css test... 07:47:22 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpmgfGbm/profile http://localhost:49245/getInfo.html) 07:47:24 INFO - PID 1629 | __metrics Screen width/height:1600/1200 07:47:24 INFO - PID 1629 | colorDepth:24 07:47:24 INFO - PID 1629 | Browser inner width/height: 1024/689 07:47:24 INFO - PID 1629 | __metrics 07:47:24 INFO - PID 1629 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:47:24 INFO - PID 1629 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:47:25 INFO - TEST-INFO | 1629: exit 0 07:47:25 INFO - Browser initialized. 07:47:25 INFO - Running cycle 1/1 for dromaeo_css test... 07:47:25 INFO - TEST-INFO | started process 1631 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpmgfGbm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:37 INFO - PID 1631 | RSS: Main: 233562112 07:47:37 INFO - PID 1631 | 07:50:42 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 07:50:44 INFO - PID 1631 | RSS: Main: 403554304 07:50:44 INFO - PID 1631 | 07:52:27 INFO - PID 1631 | ************************* 07:52:27 INFO - PID 1631 | A coding exception was thrown and uncaught in a Task. 07:52:27 INFO - PID 1631 | 07:52:27 ERROR - PID 1631 | Full message: TypeError: NetworkError when attempting to fetch resource. 07:52:27 INFO - PID 1631 | Full stack: 07:52:27 INFO - PID 1631 | ************************* 07:53:47 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 07:53:48 INFO - PID 1631 | RSS: Main: 368345088 07:53:48 INFO - PID 1631 | 07:56:51 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 07:56:51 INFO - PID 1631 | RSS: Main: 344363008 07:56:51 INFO - PID 1631 | 07:59:54 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 07:59:54 INFO - PID 1631 | RSS: Main: 358494208 07:59:54 INFO - PID 1631 | 08:02:58 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 08:02:59 INFO - PID 1631 | RSS: Main: 333160448 08:02:59 INFO - PID 1631 | 08:06:02 INFO - PID 1631 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 08:06:02 INFO - PID 1631 | RSS: Main: 516907008 08:06:02 INFO - PID 1631 | 08:06:02 INFO - PID 1631 | __start_tp_report 08:06:02 INFO - PID 1631 | _x_x_mozilla_page_load 08:06:02 INFO - PID 1631 | _x_x_mozilla_page_load_details 08:06:02 INFO - PID 1631 | |i|pagename|runs| 08:06:02 INFO - PID 1631 | |0;dojo.html;3065.9999999999995;3476.6349533299017;3505.9123521911965;3548.9290214195717;3561.893143205703;6102.511799056076;6140.938590614092;6142.836439233798;6151.4463698267145;6161.661108639023;6050.065772294828;6122.35715249899;6132.754689812402;6142.81571552853;6164.383561643834;5068.898622027557;5422.15956526737;5509.917351239735;5521.779128834862;5634.859128521799;5535.474129957647;5581.581381396391;5592.5246354059755;5613.971930140344;5617.129344951519;5326.280952071459;5358.062339090644;5381.623286369956;5388.515033646991;5389.622726409153;5410.48600382963;5425.511703946664;5426.511613954763;5429.972850135763;5433.402325744165;5331.360236771612;5392.649477783971;5393.622446428752;5398.028354896156;5404.135338345845;5956.821295361146;6045.093236014589;6045.33501314855;6048.758049678007;6071.483923866476;6329.272133704637;6380.840478988016;6387.489000879918;6396.232452105777;6425.871482570369;5134.897302053975;6459.483241340681;6470.288268290485;6540.9345906541275;6624.6025238485845;6256.937430625681;6264.655443950581;6266.279377871512;6270.874582508324;6289.308176100625;6714.899276510759;6719.731210751613;6729.528932974743;6730.865382692319;6746.156730408699;6238.844028899223;6303.464205542488;6304.968475157595;6350.841228969312;6414.230292364946;6541.985992171221;6549.886519291732;6559.836004099936;6567.2447668518735;6570.507211959122;5368.785248590013;6446.645434501053;6456.483481321483;6458.483321334376;6465.450436712838;6277.811665650038;6304.495640348853;6340.873182536324;6475.773347932894;6490.870182596416;5230.163173892159;5245.160774276097;5256.2115682647145;5300.913312770873;5305.761240744176;4637.698549594265;4645.326427667969;4659.4175728034;4661.091087238024;4694.178518759271;5986.431289027535;6107.083937409424;6122.326544080148;6144.754209831646;6163.414475624809;5457.754401051962;6360.936390636127;6380.968095159495;6420.422162005442;6499.512536559777;5086.694798312114;6132.540059495555;6134.202553667995;6134.877302453926;6150.323464418911;5737.3688894221605;5762.971185144132;5766.740496677659;5778.479936805624;5781.971090144522;6400;6541.934580654323;6550.082988381535;6554.246261679968;6731.427828634621;6349.6507692077375;6387.904181437189;6428.967855160881;6474.0612611172055;6509.446697030806;6620.933790662224;6651.235107962646;6683.064370988162;6698.7320507179165;6698.83252918681;6456.612603243632;6462.321456247214;6468.2561505427475;6468.838279043061;6470.158879345655;6278.152449419453;6346.174997250328;6441.452476539546;6442.967785161231;6501.2523559791225;6156.969215153896;6232.594881332699;6244.344343843831;6320.810375688737;6326.525510586816;4980.05378977993;5550.417206193453;6168.599041062316;6213.565050446426;6222.502199824094;6122.855605810045;6133.977404287646;6168.35232300602;6229.937700622936;6241.21984751906;6324.051392291193;6334;6335.334789847;6346.3019067903415;6357.332480089524;6136.815895523141;6144.893919094606;6236.719347629277;6253.09330147117;6353.618782873043 08:06:02 INFO - PID 1631 | |1;ext.html;749.5090715581292;792.4492477727978;814.9348052155826;1121.4448847820336;1147.9770404591914;27441;27841.58237626435;27889.442211155765;36802;37290.81354593223;31038.913638022674;31739.889103881367;39347;39683.8094857154;39703;7154.856902861952;8618.482891026528;8624.655013799473;8626.827463450727;8631.69789057383;6035.879282414371;6182.5981311214855;8305.294050005727;8486.830263394728;8606.698765543208;8560.529170895597;8578.871316930252;8579.828403431928;8719.346049046348;8733.995590507078;8646.092160323169;8689.56552172392;8701.60842762071;8703.912960870373;8730.476171429735;6027.668478233695;6151.261848578154;7945.880811787828;7996.0804507481225;8341.8331633367;37296.81351593252;37696.62303376959;37792;39614;39693.20613587741;2903.216131644444;2971.5839782430476;2971.9108426747234;3006.4438078955463;3009.9849500752575;27157.864210679018;27424.040158594355;27507.862460687567;27635.447291054068;28508;2787;2799.286182023591;2840.3609187932757;2846.985765071182;2847.2454799478155;301603;302105;302733;303468;303566.48216758773;49720.25419618709;49805.50583482502;49849.003019939395;49875.501244987085;49894.25158622624;51195.48804511982;51241;51259.487405126216;51312.74343628258;51415.71460713512;14394.568162954918;14770.926145369205;14776.26118694061;14792.630184245265;14819.036762610396;12014.098942579341;12021.338826364634;12024.218425802295;12025.579104731292;12038.759224815454;11228.66314010581;11290.379029153475;11309.377984210783;11336.319820810777;13815.723685526233;4837.161686608253;5080.6790234539285;5724.570657200727;5735.053716136874;5858.882822343529;944;944.5041353289578;980.0738302304396;994.4387311920216;1029.2846471702244;20679.483012924495;24515.632265516033;24899.87550062238;25158.119465818607;25413.237602871573;909.8817153769968;1009.7576581620505;1103.1450625764935;1122.6575894352302;1122.9157813164045;12130.636080917586;12778.041646876522;12830.29433381173;12851;12855.357232138544;463531;467856;468493;469540;469624;58097.54756131046;58339.416605834245;58413.70793146007;58493.245202643986;58502.414975850545;1437.5687293812023;1479.7114562660179;1520.1107352198867;1530.9387624495118;1545.4359158907143;24039.049413214994;24413.26760197197;24470.021199151834;24499.510009800062;24571.14001009956;40574.59425405708;40628.18743625052;40628.78113656595;40804.59195408127;40845.97885052778;421058;421145;422115;422870;423437;33653;34587.827060865544;34701.652983469845;34730.82634586811;34752;44030;44368;44520.66438006865;44537.33194002158;45410.77294613638;24960.750392495844;29675.85162074176;30656.92700755463;30699.846500767355;30751.692483074883;24822.37944051413;25287.494250114527;25347.87326063432;25991.870040649676;26456.722703716674;35842.82078589591;36631.63368366389;37081.629183708894;37182;37248.88253352404;29476.410471790874;29646.703532964395;29838.85080574583;30308.84845575758;31252.843735781174;17877.195526201613;21323.60291912451;23024.309270721904;23375.649365259877;23502.412439689146 08:06:02 INFO - PID 1631 | |2;jquery.html;382.37879337143863;422.3609688206753;434.3376351064626;437.9846705365312;453.27249764128595;17283.82716172838;20929.47676308091;21985.120595176195;22270.220542281022;22344.664830027523;17810.198541065653;18653.720194197096;23175.072997080097;23178.21861376633;23708.407289817762;5741.971290143543;5815.302163740357;6015.3082395524525;6244;6244.56288059836;6056.364081771417;6168.84577885552;6169.938300617004;6188.78339258126;6201.875962480748;5748.798792042279;5976.3724808895095;6037.184980027706;6151.630902145863;6169.5064394848305;5978.432048955342;6025.0359942409;6025.276966763972;6025.397460253984;6032.728527216242;5255.737213139328;5347.54545863602;5451.073317535989;5451.618386712932;5456.236126942231;26530.86734566334;27012.459750804876;27097.1870843875;27124.457510849672;28037.299067523272;2009.095906841927;2020.8585399022074;2047.7849825768378;2137.8931053447423;2141.753698324697;15734.842651573452;15944.362225510966;16231.59421014484;16800.83199168005;17166.39917602878;1508.3287936868098;1540.753479443295;1553.3243039277838;1572.9292181851845;1621.7324141516635;143181.56818431788;148689;149097.99999999892;150092;152000.23999880042;10884.401357925231;11375.26060806045;11991.64025079249;12129.393530323625;12623.495060197489;14394.136351818715;15171.165585892883;15459;15611.297491612677;15613.98509096905;6889.276625954303;8616.741497755078;8669.523176225368;8811.030786613468;8859.291256699578;7580.1661817200065;7757.650905709256;8186.508809471451;8198.221168988937;8305.46014509055;7434.3309102181065;7574.810629734301;7594.962025189839;7608.353289970304;7635.541867487968;2127.7340332458443;2133.445304220914;2136.156218293765;2139.5074737930136;2284.6573014048026;849.2993280543576;913.2283220678516;915.7527467583715;920.8987011428737;961.6538046303325;19316.125439974727;19975.001249937446;20460.283890063776;20582.27962021322;20898.686519702216;779.742684913977;815.7063457155419;897.1656359585648;944.631593678466;945.3881132668783;9371.563900871302;9951.402915825074;10113.039261270167;10683.465826708634;10799.082078023299;666095.6695216493;681545;689386;705823;711080.0013999279;119413;132653;139522;148254;148844.25577872258;1178.6699724077273;1209.1354681402838;1243.210561293585;1245.2466257914014;1246.8316777235138;16897.66204675924;20094.69857952161;20289.898550507154;21118.68321975141;21151.471213219793;61471.385286146564;62619.6869015652;63262;63588.04617930827;63693.12756522746;86548;86614.56692716497;87905.56047219723;88609;90027.09972900187;8257;8473.576321183793;8514.48913065218;8550.529720865412;8619.17675112658;9547;12669.556565520163;12943.5469758558;13249.735005300034;13352.198868067948;10707.732306692084;11492.770144596894;11731.589394371156;11761.235519691534;11809.23239989398;8467.872981905153;9556.61773529051;10477.58089676435;10500.789984200426;10790.62232821879;11243.739315598385;11869.821952670889;11874.346910919983;11884.762304753684;11981.64055078349;8218;8230.547319897463;8514.765359023031;8723.389362744547;8726.956365218133;11113.110951123728;11408.429578521207;11431.485583148944;11574.247673901169;11818.172727908965 08:06:02 INFO - PID 1631 | |3;mootools.html;1234.740704452065;1424.7364237616036;1443.7401267771797;1451.8330392004916;1459.9416023359065;10294.588216471342;10732.409717465536;10733.248672592921;10735.302205356646;10749.677509674702;9390.389624674408;10467.528961196746;10494.895051049487;10799.730006749835;10820.242583019191;2261.547690461906;2370.265217782493;2377.476955069882;2378.227076200233;2378.940526486834;2300.919467818627;2446.021591363451;2455.0916161020446;2457.1645640482234;2460.1635443949053;2006.3278801601482;2047.9488012799725;2132.680097985307;2337.9883100584557;2461.163204510466;2402.903883844644;2449.6570480132796;2452.1049816816912;2455.2388759484616;2459.397447625325;2365.7870791628666;2368.6802281691926;2392.772686594788;2399.8800059997106;2400.243923164215;10538.104261137813;10776.29954052984;10790.244682872202;10791.946040269828;10807.459627018696;6057.061155520857;6323.620582765003;6328.936710632881;6333.809985700436;6345.143405640272;3696.611855755134;3816.5229346331707;3973.245083434167;4075.32757095079;4082.9387559186634;1143.0741099709178;1177.0759953436511;1178.3460179600404;1218.7318789866215;1243.5150291386367;14951;15139.394424223017;15277.847221527865;15288.92977491576;15337.386504539805;5261.552768014762;5533.3083364579425;5619.943800562024;5632.183333416713;5639.154126881001;12737.299448530235;12738.80891786624;12745.235285882876;12749.362531873368;12755.61733148007;6334.493240540745;6336.904946425807;6355.555111142268;6356.68216589178;6358.745650173942;5513.3108361454815;5552.08390615552;5717.22817419643;5762.74067666956;5776.220210271559;4229.196452673982;4375.256206444912;4385.583369579885;4432.445944256968;4440.622547083534;1320.7217549726645;1357.8845798107272;1358.5041459867077;1378.6070969773566;1380.9378577964017;756.7313603670727;762.5996351915178;793.9325157361574;798.5727635714865;811.0429692962362;5298.337707786527;5887.175795388649;5944.7027648617395;6091.116788065706;6112.358202388774;571.8713289509827;586.3842964886852;601.3595520770366;602.6835911146683;603.4659326496082;3566.6076731559506;3701.5188025556504;3789.5073640426567;3799.3351163546267;3806.885793426202;13140.211587304791;13780.379882905294;13781.724365512633;13790.241536715577;13852.961027922946;11092.611758588571;13059.34703264833;13485;13699.794503082461;13744.03791734589;9781.706548803548;10099.69700908974;10117.848232276521;10147.543360548792;10150.086492215883;6126.08108783686;6312.905306420315;6367.554271200971;6383.616982981036;6418.6469744164515;11985.820212696643;12058.698532536757;12086.576969806367;12250.387480626112;12278.386080696107;12419.503219871103;12573.994080473358;12609.810852837398;12692.555760548337;12735.108542401942;8566.91433085661;8862.512561809162;8944.776380590538;9072.591733371883;9229.215516680888;9943.651972180938;10005.249606279704;10089.445080520642;10095.141912937483;10107.69676909694;8391.622376992927;8400.83198336042;8481.787955301166;8520.318374530147;8555;7727.690892364242;7769.456138070281;7835.843283134192;7848.175941526286;7886.802829929297;7552.509086909334;7717.2282771722375;7739.806504837424;7746.883796742941;7756.185600512091;5669.886602268014;5806.912896306474;5861.531077513703;5906.675132867562;5990.221271234712;5537.778488860562;5684.8010319638615;5742.454466825645;5794.101914203306;5890.352061273342 08:06:02 INFO - PID 1631 | |4;prototype.html;359.60802725029714;387.33765261403;398.8863173995411;411.62747713319436;412.1386302627509;4958.900821983562;5806.909512575475;5982.252218472691;6064.423879731429;6223.626582405059;4903.239997800338;5243.397009343927;5970.522358211343;6075.119107729377;6084.634921904689;3944.9211015779665;4786;4816;4842.080004799094;4844.903101937959;4539.818407263706;4669.929951050737;4684.391029166203;4794.328793968847;4835.395575553056;4748.987105895513;4765.594924431428;4765.880852978668;4789.952100478986;4791.976040119795;4747.430308363018;4757.405324334458;4778;4791.784369703371;4802.951970480285;3973.8609148679657;4172.7895852852525;4248.681348898814;4263.936040959388;4270.7864606769535;4860.684055536379;5417.8103766367985;5982.491488223506;6000.909986350208;6033.456988870978;4124.731892426983;5228.320318358627;5250.637213254051;5328.413874473805;5491.039068163055;4991.126552853272;5589.469000444992;6540.182477190351;6599.175103112111;6649.3350664933605;4088.7751173685438;4119.814608342632;4346.739195648272;4350.129974005212;4719.5044520325555;6063.060225664941;6303.7163327649905;6650.567713098633;6918.135233095863;6930.861382772367;4488.932666010012;4848.7090774553635;4849.75751212438;4852.636052296021;4853.538913803183;4593.517680643485;4701.059788042337;4939.950600494021;4940.036692844861;4959.528844759742;4389.18800021997;4588.6099681526775;5319.175527793198;5446.591505637093;5503.834884953458;6079.969600151971;6436.710348034349;6670.73256081343;6679.491343343224;6739.393454589012;1603.575052611059;1668.5650340706982;1678.6403013559056;1687.8902871313326;1689.3580439432938;970.427447805798;1112.1436493899653;1157.9594714184964;1159.5709587452698;1167.73142177298;6085.330613632497;6088.11722300264;6089.695515224221;6107.969460152671;6129.2032035835055;5331.773692050772;6767.864642707217;6775.258617675445;6792.286809884891;6801.65991700413;5504.862378440571;5732.853429314154;5800.50695690871;6083.69581520931;6122.693865306717;2829.405824776779;3427.091820667525;3588.7977527528046;3589.587197472272;3593.514875491775;6146.815595532141;6598.736050557924;6953.756618518328;7034.467591666996;7108.502404831612;5712.914546236202;6553.246376666649;6987.161540615159;6994.950757386433;7002.824929376807;5948.988671925783;6068.998615228438;6798.456123510206;6989.623528000504;7037.437005039585;6793.89809152873;6796.694148763218;6798.796036118924;6807.557508762113;6817.965910170417;6210.944139496387;6218.657973811484;6754.054432379569;6781.6270105144695;6794.558353706993;5412.8105516308315;6017.909731354121;6279.811605651837;7087.086486648679;7126.322999315057;4257.510386305491;4374.606285434326;4478.484974228006;4480.865574032784;4492.191405546902;5687.715614219355;5824.767009319749;6315.336889626523;6440.871182576228;6567.638779867153;6544.382247101197;6581.80254592363;6604.966975165094;6616.338366163538;6627.1716035495565;5946;6209.2548894133;6473.838154046187;6528.388644542221;6571.915633920349;4999.500049994971;6417.582857114273;6419.711113000019;6421.486281097595;6491.48068154537;6334.714937827901;6368.87262254743;6540.705668244846;6556.3443655635965;6594.670266486753;6412.422881940648;6415.069814876723;6425.518086143651;6468.514861385321;6479.643619600779 08:06:02 INFO - PID 1631 | |5;yui.html;723.6851969393311;724.3517052238246;743.0860042148157;745.910490741111;768.4735955870229;14635;15532.767008494882;15533.301001454933;15561.299741511632;15608.609784755372;12761.617151485447;14017.229052402114;14678.63303417415;14945.551633450987;15309.846901530982;907.5961197267219;928.6053427293407;931.2038207332735;933.5658918602849;933.9906600934006;939.5161491831713;945.1776954049952;949.0699114867434;974.3033730882418;989.4607438945756;1023.6059117239879;1030.9742256443612;1031.4224034540644;1032.1433210435357;1033.7880734449457;1022.3456987527989;1023.7338292044085;1025.3540269630084;1025.4155131575005;1027.3938376357985;755.1844008470838;756.5536333563224;757.4924800383701;758.2379708393084;758.8482303539314;15744.606384840356;16210.513684589363;16252;16282.267297971619;16549.83450165495;14403.135811851322;14604.050736702187;14649.257145130148;14690.559283221413;15370.077795332316;11278.605248816335;11476.540938362456;11518.654440366803;11542.884571154349;11854.449018916483;2956.3348246644546;2982.478066338404;3071.078676397094;3073.0319949215927;3074.3543855790313;108358;109499;111877;111912;112051.75896482024;10618.840717389245;11027.779444411068;11199;11381.544738210545;11632.418379081013;24746.876265618557;24976.250712478653;25110.246692599252;25136.74863251344;25257;7611.467197296247;7702.422318326148;7878.527288362717;7949.801254968556;7958.482698624571;4018.65841403484;4053.2906741320153;4078.2455245779624;4180.916381672349;4186.267403204427;4095.406166105898;4121.443605113272;4201.915961680749;4202.810873510699;4369.628581570539;835.6879698872833;839.4585492357518;844.4975239732349;846.7375113714768;854.1927878155208;558.5364147757351;561.9100943848964;565.2199964049586;569.880325131727;572.4447286132445;9505.39568345321;9939.50302484873;9999.950000249952;10170.288079834489;10200.948995254976;534.156033467121;570.3127731084033;578.8697543052864;588.8704485013291;597.4413922981939;3676.9448458273146;4703.223968045303;4787;4788;4834.853978246185;98692.51961220587;99965;100390;101251;102831;69453;74664.25335746573;80032;86066.56966715127;88180;46633.5336646636;51869.44391668256;53384;71157.28842711507;74371.14072148023;9166.450012999241;10590.940905909347;10650.84023739629;10795.857426770955;10921.126309895031;28110.718892811627;36844.26311473702;37009.81495092615;37114.628853712195;37301.6269837309;46988.59034228978;48310;48410.5158948406;48505.54483365505;49154.262686059024;13203.421346225363;13270.402831872396;13409.262490563113;13703.794443083163;13833.377498012413;14231.430742770173;14231.715365692835;14307.57077287683;14528.128312301296;14770.48303309379;13209.933950330571;13406.262655554037;13622.114562553403;13761.518346857813;14166.150030998173;13051.28217948022;13320.733585328433;13348.265845378597;13376.264305462904;14129.293535323399;12863.421146048264;13137.671558210739;13335.199888006751;13345.345405133497;14016.08895421835;9448.385854919408;9463.392269818838;9507.809843802946;9535.47554884488;10105.848412273968;6887.709641011441;9856.605735770489;10833.241673082808;10975.176861735243;11113.444327783416 08:06:03 INFO - PID 1631 | __end_tp_report 08:06:03 INFO - PID 1631 | __start_cc_report 08:06:03 INFO - PID 1631 | _x_x_mozilla_cycle_collect,1958 08:06:03 INFO - PID 1631 | __end_cc_report 08:06:03 INFO - PID 1631 | __startTimestamp1490281562986__endTimestamp 08:06:03 INFO - PID 1631 | 08:06:03 INFO - PID 1631 | ------- Summary: start ------- 08:06:03 INFO - PID 1631 | Number of tests: 6 08:06:03 INFO - PID 1631 | 08:06:03 INFO - PID 1631 | [#0] dojo.html Cycles:165 Average:5980.31 Median:6213.57 stddev:674.34 (10.9%) stddev-sans-first:636.48 08:06:03 INFO - PID 1631 | Values: 3066.0 3476.6 3505.9 3548.9 3561.9 6102.5 6140.9 6142.8 6151.4 6161.7 6050.1 6122.4 6132.8 6142.8 6164.4 5068.9 5422.2 5509.9 5521.8 5634.9 5535.5 5581.6 5592.5 5614.0 5617.1 5326.3 5358.1 5381.6 5388.5 5389.6 5410.5 5425.5 5426.5 5430.0 5433.4 5331.4 5392.6 5393.6 5398.0 5404.1 5956.8 6045.1 6045.3 6048.8 6071.5 6329.3 6380.8 6387.5 6396.2 6425.9 5134.9 6459.5 6470.3 6540.9 6624.6 6256.9 6264.7 6266.3 6270.9 6289.3 6714.9 6719.7 6729.5 6730.9 6746.2 6238.8 6303.5 6305.0 6350.8 6414.2 6542.0 6549.9 6559.8 6567.2 6570.5 5368.8 6446.6 6456.5 6458.5 6465.5 6277.8 6304.5 6340.9 6475.8 6490.9 5230.2 5245.2 5256.2 5300.9 5305.8 4637.7 4645.3 4659.4 4661.1 4694.2 5986.4 6107.1 6122.3 6144.8 6163.4 5457.8 6360.9 6381.0 6420.4 6499.5 5086.7 6132.5 6134.2 6134.9 6150.3 5737.4 5763.0 5766.7 5778.5 5782.0 6400.0 6541.9 6550.1 6554.2 6731.4 6349.7 6387.9 6429.0 6474.1 6509.4 6620.9 6651.2 6683.1 6698.7 6698.8 6456.6 6462.3 6468.3 6468.8 6470.2 6278.2 6346.2 6441.5 6443.0 6501.3 6157.0 6232.6 6244.3 6320.8 6326.5 4980.1 5550.4 6168.6 6213.6 6222.5 6122.9 6134.0 6168.4 6229.9 6241.2 6324.1 6334.0 6335.3 6346.3 6357.3 6136.8 6144.9 6236.7 6253.1 6353.6 08:06:03 INFO - PID 1631 | 08:06:03 INFO - PID 1631 | [#1] ext.html Cycles:180 Average:52924.26 Median:34741.41 stddev:107310.75 (308.9%) stddev-sans-first:107540.29 08:06:03 INFO - PID 1631 | Values: 749.5 792.4 814.9 1121.4 1148.0 27441.0 27841.6 27889.4 36802.0 37290.8 31038.9 31739.9 39347.0 39683.8 39703.0 7154.9 8618.5 8624.7 8626.8 8631.7 6035.9 6182.6 8305.3 8486.8 8606.7 8560.5 8578.9 8579.8 8719.3 8734.0 8646.1 8689.6 8701.6 8703.9 8730.5 6027.7 6151.3 7945.9 7996.1 8341.8 37296.8 37696.6 37792.0 39614.0 39693.2 2903.2 2971.6 2971.9 3006.4 3010.0 27157.9 27424.0 27507.9 27635.4 28508.0 2787.0 2799.3 2840.4 2847.0 2847.2 301603.0 302105.0 302733.0 303468.0 303566.5 49720.3 49805.5 49849.0 49875.5 49894.3 51195.5 51241.0 51259.5 51312.7 51415.7 14394.6 14770.9 14776.3 14792.6 14819.0 12014.1 12021.3 12024.2 12025.6 12038.8 11228.7 11290.4 11309.4 11336.3 13815.7 4837.2 5080.7 5724.6 5735.1 5858.9 944.0 944.5 980.1 994.4 1029.3 20679.5 24515.6 24899.9 25158.1 25413.2 909.9 1009.8 1103.1 1122.7 1122.9 12130.6 12778.0 12830.3 12851.0 12855.4 463531.0 467856.0 468493.0 469540.0 469624.0 58097.5 58339.4 58413.7 58493.2 58502.4 1437.6 1479.7 1520.1 1530.9 1545.4 24039.0 24413.3 24470.0 24499.5 24571.1 40574.6 40628.2 40628.8 40804.6 40846.0 421058.0 421145.0 422115.0 422870.0 423437.0 33653.0 34587.8 34701.7 34730.8 34752.0 44030.0 44368.0 44520.7 44537.3 45410.8 24960.8 29675.9 30656.9 30699.8 30751.7 24822.4 25287.5 25347.9 25991.9 26456.7 35842.8 36631.6 37081.6 37182.0 37248.9 29476.4 29646.7 29838.9 30308.8 31252.8 17877.2 21323.6 23024.3 23375.6 23502.4 08:06:03 INFO - PID 1631 | 08:06:03 INFO - PID 1631 | [#2] jquery.html Cycles:180 Average:39666.40 Median:26771.66 stddev:115559.01 (431.6%) stddev-sans-first:115845.53 08:06:03 INFO - PID 1631 | Values: 382.4 422.4 434.3 438.0 453.3 17283.8 20929.5 21985.1 22270.2 22344.7 17810.2 18653.7 23175.1 23178.2 23708.4 5742.0 5815.3 6015.3 6244.0 6244.6 6056.4 6168.8 6169.9 6188.8 6201.9 5748.8 5976.4 6037.2 6151.6 6169.5 5978.4 6025.0 6025.3 6025.4 6032.7 5255.7 5347.5 5451.1 5451.6 5456.2 26530.9 27012.5 27097.2 27124.5 28037.3 2009.1 2020.9 2047.8 2137.9 2141.8 15734.8 15944.4 16231.6 16800.8 17166.4 1508.3 1540.8 1553.3 1572.9 1621.7 143181.6 148689.0 149098.0 150092.0 152000.2 10884.4 11375.3 11991.6 12129.4 12623.5 14394.1 15171.2 15459.0 15611.3 15614.0 6889.3 8616.7 8669.5 8811.0 8859.3 7580.2 7757.7 8186.5 8198.2 8305.5 7434.3 7574.8 7595.0 7608.4 7635.5 2127.7 2133.4 2136.2 2139.5 2284.7 849.3 913.2 915.8 920.9 961.7 19316.1 19975.0 20460.3 20582.3 20898.7 779.7 815.7 897.2 944.6 945.4 9371.6 9951.4 10113.0 10683.5 10799.1 666095.7 681545.0 689386.0 705823.0 711080.0 119413.0 132653.0 139522.0 148254.0 148844.3 1178.7 1209.1 1243.2 1245.2 1246.8 16897.7 20094.7 20289.9 21118.7 21151.5 61471.4 62619.7 63262.0 63588.0 63693.1 86548.0 86614.6 87905.6 88609.0 90027.1 8257.0 8473.6 8514.5 8550.5 8619.2 9547.0 12669.6 12943.5 13249.7 13352.2 10707.7 11492.8 11731.6 11761.2 11809.2 8467.9 9556.6 10477.6 10500.8 10790.6 11243.7 11869.8 11874.3 11884.8 11981.6 8218.0 8230.5 8514.8 8723.4 8727.0 11113.1 11408.4 11431.5 11574.2 11818.2 08:06:03 INFO - PID 1631 | 08:06:03 INFO - PID 1631 | [#3] mootools.html Cycles:180 Average:6692.90 Median:2460.66 stddev:4169.40 (169.4%) stddev-sans-first:4160.92 08:06:03 INFO - PID 1631 | Values: 1234.7 1424.7 1443.7 1451.8 1459.9 10294.6 10732.4 10733.2 10735.3 10749.7 9390.4 10467.5 10494.9 10799.7 10820.2 2261.5 2370.3 2377.5 2378.2 2378.9 2300.9 2446.0 2455.1 2457.2 2460.2 2006.3 2047.9 2132.7 2338.0 2461.2 2402.9 2449.7 2452.1 2455.2 2459.4 2365.8 2368.7 2392.8 2399.9 2400.2 10538.1 10776.3 10790.2 10791.9 10807.5 6057.1 6323.6 6328.9 6333.8 6345.1 3696.6 3816.5 3973.2 4075.3 4082.9 1143.1 1177.1 1178.3 1218.7 1243.5 14951.0 15139.4 15277.8 15288.9 15337.4 5261.6 5533.3 5619.9 5632.2 5639.2 12737.3 12738.8 12745.2 12749.4 12755.6 6334.5 6336.9 6355.6 6356.7 6358.7 5513.3 5552.1 5717.2 5762.7 5776.2 4229.2 4375.3 4385.6 4432.4 4440.6 1320.7 1357.9 1358.5 1378.6 1380.9 756.7 762.6 793.9 798.6 811.0 5298.3 5887.2 5944.7 6091.1 6112.4 571.9 586.4 601.4 602.7 603.5 3566.6 3701.5 3789.5 3799.3 3806.9 13140.2 13780.4 13781.7 13790.2 13853.0 11092.6 13059.3 13485.0 13699.8 13744.0 9781.7 10099.7 10117.8 10147.5 10150.1 6126.1 6312.9 6367.6 6383.6 6418.6 11985.8 12058.7 12086.6 12250.4 12278.4 12419.5 12574.0 12609.8 12692.6 12735.1 8566.9 8862.5 8944.8 9072.6 9229.2 9943.7 10005.2 10089.4 10095.1 10107.7 8391.6 8400.8 8481.8 8520.3 8555.0 7727.7 7769.5 7835.8 7848.2 7886.8 7552.5 7717.2 7739.8 7746.9 7756.2 5669.9 5806.9 5861.5 5906.7 5990.2 5537.8 5684.8 5742.5 5794.1 5890.4 08:06:03 INFO - PID 1631 | 08:06:03 INFO - PID 1631 | [#4] prototype.html Cycles:180 Average:5299.53 Median:5885.38 stddev:1598.72 (27.2%) stddev-sans-first:1559.62 08:06:03 INFO - PID 1631 | Values: 359.6 387.3 398.9 411.6 412.1 4958.9 5806.9 5982.3 6064.4 6223.6 4903.2 5243.4 5970.5 6075.1 6084.6 3944.9 4786.0 4816.0 4842.1 4844.9 4539.8 4669.9 4684.4 4794.3 4835.4 4749.0 4765.6 4765.9 4790.0 4792.0 4747.4 4757.4 4778.0 4791.8 4803.0 3973.9 4172.8 4248.7 4263.9 4270.8 4860.7 5417.8 5982.5 6000.9 6033.5 4124.7 5228.3 5250.6 5328.4 5491.0 4991.1 5589.5 6540.2 6599.2 6649.3 4088.8 4119.8 4346.7 4350.1 4719.5 6063.1 6303.7 6650.6 6918.1 6930.9 4488.9 4848.7 4849.8 4852.6 4853.5 4593.5 4701.1 4940.0 4940.0 4959.5 4389.2 4588.6 5319.2 5446.6 5503.8 6080.0 6436.7 6670.7 6679.5 6739.4 1603.6 1668.6 1678.6 1687.9 1689.4 970.4 1112.1 1158.0 1159.6 1167.7 6085.3 6088.1 6089.7 6108.0 6129.2 5331.8 6767.9 6775.3 6792.3 6801.7 5504.9 5732.9 5800.5 6083.7 6122.7 2829.4 3427.1 3588.8 3589.6 3593.5 6146.8 6598.7 6953.8 7034.5 7108.5 5712.9 6553.2 6987.2 6995.0 7002.8 5949.0 6069.0 6798.5 6989.6 7037.4 6793.9 6796.7 6798.8 6807.6 6818.0 6210.9 6218.7 6754.1 6781.6 6794.6 5412.8 6017.9 6279.8 7087.1 7126.3 4257.5 4374.6 4478.5 4480.9 4492.2 5687.7 5824.8 6315.3 6440.9 6567.6 6544.4 6581.8 6605.0 6616.3 6627.2 5946.0 6209.3 6473.8 6528.4 6571.9 4999.5 6417.6 6419.7 6421.5 6491.5 6334.7 6368.9 6540.7 6556.3 6594.7 6412.4 6415.1 6425.5 6468.5 6479.6 08:06:03 INFO - PID 1631 | 08:06:03 INFO - PID 1631 | [#5] yui.html Cycles:180 Average:18941.16 Median:3026.78 stddev:27156.81 (897.2%) stddev-sans-first:27198.54 08:06:03 INFO - PID 1631 | Values: 723.7 724.4 743.1 745.9 768.5 14635.0 15532.8 15533.3 15561.3 15608.6 12761.6 14017.2 14678.6 14945.6 15309.8 907.6 928.6 931.2 933.6 934.0 939.5 945.2 949.1 974.3 989.5 1023.6 1031.0 1031.4 1032.1 1033.8 1022.3 1023.7 1025.4 1025.4 1027.4 755.2 756.6 757.5 758.2 758.8 15744.6 16210.5 16252.0 16282.3 16549.8 14403.1 14604.1 14649.3 14690.6 15370.1 11278.6 11476.5 11518.7 11542.9 11854.4 2956.3 2982.5 3071.1 3073.0 3074.4 108358.0 109499.0 111877.0 111912.0 112051.8 10618.8 11027.8 11199.0 11381.5 11632.4 24746.9 24976.3 25110.2 25136.7 25257.0 7611.5 7702.4 7878.5 7949.8 7958.5 4018.7 4053.3 4078.2 4180.9 4186.3 4095.4 4121.4 4201.9 4202.8 4369.6 835.7 839.5 844.5 846.7 854.2 558.5 561.9 565.2 569.9 572.4 9505.4 9939.5 10000.0 10170.3 10200.9 534.2 570.3 578.9 588.9 597.4 3676.9 4703.2 4787.0 4788.0 4834.9 98692.5 99965.0 100390.0 101251.0 102831.0 69453.0 74664.3 80032.0 86066.6 88180.0 46633.5 51869.4 53384.0 71157.3 74371.1 9166.5 10590.9 10650.8 10795.9 10921.1 28110.7 36844.3 37009.8 37114.6 37301.6 46988.6 48310.0 48410.5 48505.5 49154.3 13203.4 13270.4 13409.3 13703.8 13833.4 14231.4 14231.7 14307.6 14528.1 14770.5 13209.9 13406.3 13622.1 13761.5 14166.2 13051.3 13320.7 13348.3 13376.3 14129.3 12863.4 13137.7 13335.2 13345.3 14016.1 9448.4 9463.4 9507.8 9535.5 10105.8 6887.7 9856.6 10833.2 10975.2 11113.4 08:06:03 INFO - PID 1631 | -------- Summary: end -------- 08:06:03 INFO - PID 1631 | 08:06:03 INFO - TEST-INFO | 1631: exit 0 08:06:03 INFO - TEST-OK | dromaeo_css | took 1121552ms 08:06:03 INFO - TEST-START | kraken 08:06:03 INFO - operating with platform_type : mac_ 08:06:03 INFO - Initialising browser for kraken test... 08:06:03 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpWDld2w/profile http://localhost:49245/getInfo.html) 08:06:06 INFO - PID 1641 | __metrics Screen width/height:1600/1200 08:06:06 INFO - PID 1641 | colorDepth:24 08:06:06 INFO - PID 1641 | Browser inner width/height: 1024/689 08:06:06 INFO - PID 1641 | __metrics 08:06:06 INFO - PID 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:06:06 INFO - PID 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:06:07 INFO - TEST-INFO | 1641: exit 0 08:06:07 INFO - Browser initialized. 08:06:07 INFO - Running cycle 1/1 for kraken test... 08:06:07 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpWDld2w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:06:19 INFO - PID 1642 | RSS: Main: 233648128 08:06:19 INFO - PID 1642 | 08:06:22 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 08:06:23 INFO - PID 1642 | RSS: Main: 284827648 08:06:23 INFO - PID 1642 | 08:06:25 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 08:06:26 INFO - PID 1642 | RSS: Main: 286519296 08:06:26 INFO - PID 1642 | 08:06:29 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 08:06:30 INFO - PID 1642 | RSS: Main: 377622528 08:06:30 INFO - PID 1642 | 08:06:32 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 08:06:33 INFO - PID 1642 | RSS: Main: 280866816 08:06:33 INFO - PID 1642 | 08:06:35 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:06:35 INFO - PID 1642 | RSS: Main: 284684288 08:06:35 INFO - PID 1642 | 08:06:38 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 08:06:39 INFO - PID 1642 | RSS: Main: 325468160 08:06:39 INFO - PID 1642 | 08:06:42 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 08:06:43 INFO - PID 1642 | RSS: Main: 335753216 08:06:43 INFO - PID 1642 | 08:06:46 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 08:06:46 INFO - PID 1642 | RSS: Main: 341254144 08:06:46 INFO - PID 1642 | 08:06:48 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:06:49 INFO - PID 1642 | RSS: Main: 301625344 08:06:49 INFO - PID 1642 | 08:06:50 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:06:51 INFO - PID 1642 | RSS: Main: 305426432 08:06:51 INFO - PID 1642 | 08:06:53 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:06:54 INFO - PID 1642 | RSS: Main: 308244480 08:06:54 INFO - PID 1642 | 08:06:57 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:06:58 INFO - PID 1642 | RSS: Main: 325754880 08:06:58 INFO - PID 1642 | 08:07:01 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:07:02 INFO - PID 1642 | RSS: Main: 320184320 08:07:02 INFO - PID 1642 | 08:07:03 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 08:07:04 INFO - PID 1642 | RSS: Main: 381415424 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | __start_tp_report 08:07:04 INFO - PID 1642 | _x_x_mozilla_page_load 08:07:04 INFO - PID 1642 | _x_x_mozilla_page_load_details 08:07:04 INFO - PID 1642 | |i|pagename|runs| 08:07:04 INFO - PID 1642 | |0;ai-astar;111;112;110;110;110;110;110;119;164;113 08:07:04 INFO - PID 1642 | |1;audio-beat-detection;143;111;110;150;113;111;111;108;132;110 08:07:04 INFO - PID 1642 | |2;audio-dft;182;182;185;201;207;180;184;161;208;261 08:07:04 INFO - PID 1642 | |3;audio-fft;82;57;60;87;65;56;60;62;78;76 08:07:04 INFO - PID 1642 | |4;audio-oscillator;85;70;88;72;95;103;120;104;103;86 08:07:04 INFO - PID 1642 | |5;imaging-gaussian-blur;89;87;89;87;87;87;89;88;88;88 08:07:04 INFO - PID 1642 | |6;imaging-darkroom;95;94;115;151;95;95;96;95;114;152 08:07:04 INFO - PID 1642 | |7;imaging-desaturate;84;84;86;83;84;84;85;84;84;86 08:07:04 INFO - PID 1642 | |8;json-parse-financial;65;63;63;62;62;61;61;64;64;63 08:07:04 INFO - PID 1642 | |9;json-stringify-tinderbox;53;60;58;56;64;57;57;58;57;59 08:07:04 INFO - PID 1642 | |10;stanford-crypto-aes;82;82;85;98;106;108;105;83;83;80 08:07:04 INFO - PID 1642 | |11;stanford-crypto-ccm;140;140;138;133;142;156;140;130;193;184 08:07:04 INFO - PID 1642 | |12;stanford-crypto-pbkdf2;183;185;186;186;182;181;201;235;234;185 08:07:04 INFO - PID 1642 | |13;stanford-crypto-sha256-iterative;67;67;67;65;68;69;69;69;68;69 08:07:04 INFO - PID 1642 | __end_tp_report 08:07:04 INFO - PID 1642 | __start_cc_report 08:07:04 INFO - PID 1642 | _x_x_mozilla_cycle_collect,2150 08:07:04 INFO - PID 1642 | __end_cc_report 08:07:04 INFO - PID 1642 | __startTimestamp1490281624085__endTimestamp 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | ------- Summary: start ------- 08:07:04 INFO - PID 1642 | Number of tests: 14 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#0] ai-astar Cycles:10 Average:116.90 Median:111.50 stddev:16.78 (15.1%) stddev-sans-first:17.66 08:07:04 INFO - PID 1642 | Values: 111.0 112.0 110.0 110.0 110.0 110.0 110.0 119.0 164.0 113.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#1] audio-beat-detection Cycles:10 Average:119.90 Median:112.00 stddev:15.67 (14.0%) stddev-sans-first:14.21 08:07:04 INFO - PID 1642 | Values: 143.0 111.0 110.0 150.0 113.0 111.0 111.0 108.0 132.0 110.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#2] audio-dft Cycles:10 Average:195.10 Median:193.00 stddev:27.17 (14.1%) stddev-sans-first:28.40 08:07:04 INFO - PID 1642 | Values: 182.0 182.0 185.0 201.0 207.0 180.0 184.0 161.0 208.0 261.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#3] audio-fft Cycles:10 Average:68.30 Median:70.50 stddev:11.34 (16.1%) stddev-sans-first:10.89 08:07:04 INFO - PID 1642 | Values: 82.0 57.0 60.0 87.0 65.0 56.0 60.0 62.0 78.0 76.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#4] audio-oscillator Cycles:10 Average:92.60 Median:78.50 stddev:15.49 (19.7%) stddev-sans-first:16.19 08:07:04 INFO - PID 1642 | Values: 85.0 70.0 88.0 72.0 95.0 103.0 120.0 104.0 103.0 86.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.00 stddev:0.88 (1.0%) stddev-sans-first:0.83 08:07:04 INFO - PID 1642 | Values: 89.0 87.0 89.0 87.0 87.0 87.0 89.0 88.0 88.0 88.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#6] imaging-darkroom Cycles:10 Average:110.20 Median:95.00 stddev:23.18 (24.4%) stddev-sans-first:23.93 08:07:04 INFO - PID 1642 | Values: 95.0 94.0 115.0 151.0 95.0 95.0 96.0 95.0 114.0 152.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.00 stddev:0.97 (1.2%) stddev-sans-first:1.01 08:07:04 INFO - PID 1642 | Values: 84.0 84.0 86.0 83.0 84.0 84.0 85.0 84.0 84.0 86.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#8] json-parse-financial Cycles:10 Average:62.80 Median:63.00 stddev:1.32 (2.1%) stddev-sans-first:1.13 08:07:04 INFO - PID 1642 | Values: 65.0 63.0 63.0 62.0 62.0 61.0 61.0 64.0 64.0 63.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:2.85 (4.9%) stddev-sans-first:2.40 08:07:04 INFO - PID 1642 | Values: 53.0 60.0 58.0 56.0 64.0 57.0 57.0 58.0 57.0 59.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#10] stanford-crypto-aes Cycles:10 Average:91.20 Median:82.50 stddev:11.57 (14.0%) stddev-sans-first:11.79 08:07:04 INFO - PID 1642 | Values: 82.0 82.0 85.0 98.0 106.0 108.0 105.0 83.0 83.0 80.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#11] stanford-crypto-ccm Cycles:10 Average:149.60 Median:141.00 stddev:21.70 (15.4%) stddev-sans-first:22.73 08:07:04 INFO - PID 1642 | Values: 140.0 140.0 138.0 133.0 142.0 156.0 140.0 130.0 193.0 184.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:195.80 Median:186.00 stddev:21.14 (11.4%) stddev-sans-first:21.91 08:07:04 INFO - PID 1642 | Values: 183.0 185.0 186.0 186.0 182.0 181.0 201.0 235.0 234.0 185.0 08:07:04 INFO - PID 1642 | 08:07:04 INFO - PID 1642 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.80 Median:68.50 stddev:1.32 (1.9%) stddev-sans-first:1.36 08:07:04 INFO - PID 1642 | Values: 67.0 67.0 67.0 65.0 68.0 69.0 69.0 69.0 68.0 69.0 08:07:04 INFO - PID 1642 | -------- Summary: end -------- 08:07:04 INFO - PID 1642 | 08:07:04 INFO - TEST-INFO | 1642: exit 0 08:07:05 INFO - TEST-OK | kraken | took 61320ms 08:07:05 INFO - SUITE-END | took 1182s 08:07:05 INFO - Completed test suite (00:19:43) 08:07:05 INFO - javascript benchmark 08:07:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7573.090666264783, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.9999999999995, 3476.6349533299017, 3505.9123521911965, 3548.9290214195717, 3561.893143205703, 6102.511799056076, 6140.938590614092, 6142.836439233798, 6151.4463698267145, 6161.661108639023, 6050.065772294828, 6122.35715249899, 6132.754689812402, 6142.81571552853, 6164.383561643834, 5068.898622027557, 5422.15956526737, 5509.917351239735, 5521.779128834862, 5634.859128521799, 5535.474129957647, 5581.581381396391, 5592.5246354059755, 5613.971930140344, 5617.129344951519, 5326.280952071459, 5358.062339090644, 5381.623286369956, 5388.515033646991, 5389.622726409153, 5410.48600382963, 5425.511703946664, 5426.511613954763, 5429.972850135763, 5433.402325744165, 5331.360236771612, 5392.649477783971, 5393.622446428752, 5398.028354896156, 5404.135338345845, 5956.821295361146, 6045.093236014589, 6045.33501314855, 6048.758049678007, 6071.483923866476, 6329.272133704637, 6380.840478988016, 6387.489000879918, 6396.232452105777, 6425.871482570369, 5134.897302053975, 6459.483241340681, 6470.288268290485, 6540.9345906541275, 6624.6025238485845, 6256.937430625681, 6264.655443950581, 6266.279377871512, 6270.874582508324, 6289.308176100625, 6714.899276510759, 6719.731210751613, 6729.528932974743, 6730.865382692319, 6746.156730408699, 6238.844028899223, 6303.464205542488, 6304.968475157595, 6350.841228969312, 6414.230292364946, 6541.985992171221, 6549.886519291732, 6559.836004099936, 6567.2447668518735, 6570.507211959122, 5368.785248590013, 6446.645434501053, 6456.483481321483, 6458.483321334376, 6465.450436712838, 6277.811665650038, 6304.495640348853, 6340.873182536324, 6475.773347932894, 6490.870182596416, 5230.163173892159, 5245.160774276097, 5256.2115682647145, 5300.913312770873, 5305.761240744176, 4637.698549594265, 4645.326427667969, 4659.4175728034, 4661.091087238024, 4694.178518759271, 5986.431289027535, 6107.083937409424, 6122.326544080148, 6144.754209831646, 6163.414475624809, 5457.754401051962, 6360.936390636127, 6380.968095159495, 6420.422162005442, 6499.512536559777, 5086.694798312114, 6132.540059495555, 6134.202553667995, 6134.877302453926, 6150.323464418911, 5737.3688894221605, 5762.971185144132, 5766.740496677659, 5778.479936805624, 5781.971090144522, 6400.0, 6541.934580654323, 6550.082988381535, 6554.246261679968, 6731.427828634621, 6349.6507692077375, 6387.904181437189, 6428.967855160881, 6474.0612611172055, 6509.446697030806, 6620.933790662224, 6651.235107962646, 6683.064370988162, 6698.7320507179165, 6698.83252918681, 6456.612603243632, 6462.321456247214, 6468.2561505427475, 6468.838279043061, 6470.158879345655, 6278.152449419453, 6346.174997250328, 6441.452476539546, 6442.967785161231, 6501.2523559791225, 6156.969215153896, 6232.594881332699, 6244.344343843831, 6320.810375688737, 6326.525510586816, 4980.05378977993, 5550.417206193453, 6168.599041062316, 6213.565050446426, 6222.502199824094, 6122.855605810045, 6133.977404287646, 6168.35232300602, 6229.937700622936, 6241.21984751906, 6324.051392291193, 6334.0, 6335.334789847, 6346.3019067903415, 6357.332480089524, 6136.815895523141, 6144.893919094606, 6236.719347629277, 6253.09330147117, 6353.618782873043], "value": 5938.062952816676, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [749.5090715581292, 792.4492477727978, 814.9348052155826, 1121.4448847820336, 1147.9770404591914, 27441.0, 27841.58237626435, 27889.442211155765, 36802.0, 37290.81354593223, 31038.913638022674, 31739.889103881367, 39347.0, 39683.8094857154, 39703.0, 7154.856902861952, 8618.482891026528, 8624.655013799473, 8626.827463450727, 8631.69789057383, 6035.879282414371, 6182.5981311214855, 8305.294050005727, 8486.830263394728, 8606.698765543208, 8560.529170895597, 8578.871316930252, 8579.828403431928, 8719.346049046348, 8733.995590507078, 8646.092160323169, 8689.56552172392, 8701.60842762071, 8703.912960870373, 8730.476171429735, 6027.668478233695, 6151.261848578154, 7945.880811787828, 7996.0804507481225, 8341.8331633367, 37296.81351593252, 37696.62303376959, 37792.0, 39614.0, 39693.20613587741, 2903.216131644444, 2971.5839782430476, 2971.9108426747234, 3006.4438078955463, 3009.9849500752575, 27157.864210679018, 27424.040158594355, 27507.862460687567, 27635.447291054068, 28508.0, 2787.0, 2799.286182023591, 2840.3609187932757, 2846.985765071182, 2847.2454799478155, 301603.0, 302105.0, 302733.0, 303468.0, 303566.48216758773, 49720.25419618709, 49805.50583482502, 49849.003019939395, 49875.501244987085, 49894.25158622624, 51195.48804511982, 51241.0, 51259.487405126216, 51312.74343628258, 51415.71460713512, 14394.568162954918, 14770.926145369205, 14776.26118694061, 14792.630184245265, 14819.036762610396, 12014.098942579341, 12021.338826364634, 12024.218425802295, 12025.579104731292, 12038.759224815454, 11228.66314010581, 11290.379029153475, 11309.377984210783, 11336.319820810777, 13815.723685526233, 4837.161686608253, 5080.6790234539285, 5724.570657200727, 5735.053716136874, 5858.882822343529, 944.0, 944.5041353289578, 980.0738302304396, 994.4387311920216, 1029.2846471702244, 20679.483012924495, 24515.632265516033, 24899.87550062238, 25158.119465818607, 25413.237602871573, 909.8817153769968, 1009.7576581620505, 1103.1450625764935, 1122.6575894352302, 1122.9157813164045, 12130.636080917586, 12778.041646876522, 12830.29433381173, 12851.0, 12855.357232138544, 463531.0, 467856.0, 468493.0, 469540.0, 469624.0, 58097.54756131046, 58339.416605834245, 58413.70793146007, 58493.245202643986, 58502.414975850545, 1437.5687293812023, 1479.7114562660179, 1520.1107352198867, 1530.9387624495118, 1545.4359158907143, 24039.049413214994, 24413.26760197197, 24470.021199151834, 24499.510009800062, 24571.14001009956, 40574.59425405708, 40628.18743625052, 40628.78113656595, 40804.59195408127, 40845.97885052778, 421058.0, 421145.0, 422115.0, 422870.0, 423437.0, 33653.0, 34587.827060865544, 34701.652983469845, 34730.82634586811, 34752.0, 44030.0, 44368.0, 44520.66438006865, 44537.33194002158, 45410.77294613638, 24960.750392495844, 29675.85162074176, 30656.92700755463, 30699.846500767355, 30751.692483074883, 24822.37944051413, 25287.494250114527, 25347.87326063432, 25991.870040649676, 26456.722703716674, 35842.82078589591, 36631.63368366389, 37081.629183708894, 37182.0, 37248.88253352404, 29476.410471790874, 29646.703532964395, 29838.85080574583, 30308.84845575758, 31252.843735781174, 17877.195526201613, 21323.60291912451, 23024.309270721904, 23375.649365259877, 23502.412439689146], "value": 17373.264558594758, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.37879337143863, 422.3609688206753, 434.3376351064626, 437.9846705365312, 453.27249764128595, 17283.82716172838, 20929.47676308091, 21985.120595176195, 22270.220542281022, 22344.664830027523, 17810.198541065653, 18653.720194197096, 23175.072997080097, 23178.21861376633, 23708.407289817762, 5741.971290143543, 5815.302163740357, 6015.3082395524525, 6244.0, 6244.56288059836, 6056.364081771417, 6168.84577885552, 6169.938300617004, 6188.78339258126, 6201.875962480748, 5748.798792042279, 5976.3724808895095, 6037.184980027706, 6151.630902145863, 6169.5064394848305, 5978.432048955342, 6025.0359942409, 6025.276966763972, 6025.397460253984, 6032.728527216242, 5255.737213139328, 5347.54545863602, 5451.073317535989, 5451.618386712932, 5456.236126942231, 26530.86734566334, 27012.459750804876, 27097.1870843875, 27124.457510849672, 28037.299067523272, 2009.095906841927, 2020.8585399022074, 2047.7849825768378, 2137.8931053447423, 2141.753698324697, 15734.842651573452, 15944.362225510966, 16231.59421014484, 16800.83199168005, 17166.39917602878, 1508.3287936868098, 1540.753479443295, 1553.3243039277838, 1572.9292181851845, 1621.7324141516635, 143181.56818431788, 148689.0, 149097.99999999892, 150092.0, 152000.23999880042, 10884.401357925231, 11375.26060806045, 11991.64025079249, 12129.393530323625, 12623.495060197489, 14394.136351818715, 15171.165585892883, 15459.0, 15611.297491612677, 15613.98509096905, 6889.276625954303, 8616.741497755078, 8669.523176225368, 8811.030786613468, 8859.291256699578, 7580.1661817200065, 7757.650905709256, 8186.508809471451, 8198.221168988937, 8305.46014509055, 7434.3309102181065, 7574.810629734301, 7594.962025189839, 7608.353289970304, 7635.541867487968, 2127.7340332458443, 2133.445304220914, 2136.156218293765, 2139.5074737930136, 2284.6573014048026, 849.2993280543576, 913.2283220678516, 915.7527467583715, 920.8987011428737, 961.6538046303325, 19316.125439974727, 19975.001249937446, 20460.283890063776, 20582.27962021322, 20898.686519702216, 779.742684913977, 815.7063457155419, 897.1656359585648, 944.631593678466, 945.3881132668783, 9371.563900871302, 9951.402915825074, 10113.039261270167, 10683.465826708634, 10799.082078023299, 666095.6695216493, 681545.0, 689386.0, 705823.0, 711080.0013999279, 119413.0, 132653.0, 139522.0, 148254.0, 148844.25577872258, 1178.6699724077273, 1209.1354681402838, 1243.210561293585, 1245.2466257914014, 1246.8316777235138, 16897.66204675924, 20094.69857952161, 20289.898550507154, 21118.68321975141, 21151.471213219793, 61471.385286146564, 62619.6869015652, 63262.0, 63588.04617930827, 63693.12756522746, 86548.0, 86614.56692716497, 87905.56047219723, 88609.0, 90027.09972900187, 8257.0, 8473.576321183793, 8514.48913065218, 8550.529720865412, 8619.17675112658, 9547.0, 12669.556565520163, 12943.5469758558, 13249.735005300034, 13352.198868067948, 10707.732306692084, 11492.770144596894, 11731.589394371156, 11761.235519691534, 11809.23239989398, 8467.872981905153, 9556.61773529051, 10477.58089676435, 10500.789984200426, 10790.62232821879, 11243.739315598385, 11869.821952670889, 11874.346910919983, 11884.762304753684, 11981.64055078349, 8218.0, 8230.547319897463, 8514.765359023031, 8723.389362744547, 8726.956365218133, 11113.110951123728, 11408.429578521207, 11431.485583148944, 11574.247673901169, 11818.172727908965], "value": 10148.01066597459, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1234.740704452065, 1424.7364237616036, 1443.7401267771797, 1451.8330392004916, 1459.9416023359065, 10294.588216471342, 10732.409717465536, 10733.248672592921, 10735.302205356646, 10749.677509674702, 9390.389624674408, 10467.528961196746, 10494.895051049487, 10799.730006749835, 10820.242583019191, 2261.547690461906, 2370.265217782493, 2377.476955069882, 2378.227076200233, 2378.940526486834, 2300.919467818627, 2446.021591363451, 2455.0916161020446, 2457.1645640482234, 2460.1635443949053, 2006.3278801601482, 2047.9488012799725, 2132.680097985307, 2337.9883100584557, 2461.163204510466, 2402.903883844644, 2449.6570480132796, 2452.1049816816912, 2455.2388759484616, 2459.397447625325, 2365.7870791628666, 2368.6802281691926, 2392.772686594788, 2399.8800059997106, 2400.243923164215, 10538.104261137813, 10776.29954052984, 10790.244682872202, 10791.946040269828, 10807.459627018696, 6057.061155520857, 6323.620582765003, 6328.936710632881, 6333.809985700436, 6345.143405640272, 3696.611855755134, 3816.5229346331707, 3973.245083434167, 4075.32757095079, 4082.9387559186634, 1143.0741099709178, 1177.0759953436511, 1178.3460179600404, 1218.7318789866215, 1243.5150291386367, 14951.0, 15139.394424223017, 15277.847221527865, 15288.92977491576, 15337.386504539805, 5261.552768014762, 5533.3083364579425, 5619.943800562024, 5632.183333416713, 5639.154126881001, 12737.299448530235, 12738.80891786624, 12745.235285882876, 12749.362531873368, 12755.61733148007, 6334.493240540745, 6336.904946425807, 6355.555111142268, 6356.68216589178, 6358.745650173942, 5513.3108361454815, 5552.08390615552, 5717.22817419643, 5762.74067666956, 5776.220210271559, 4229.196452673982, 4375.256206444912, 4385.583369579885, 4432.445944256968, 4440.622547083534, 1320.7217549726645, 1357.8845798107272, 1358.5041459867077, 1378.6070969773566, 1380.9378577964017, 756.7313603670727, 762.5996351915178, 793.9325157361574, 798.5727635714865, 811.0429692962362, 5298.337707786527, 5887.175795388649, 5944.7027648617395, 6091.116788065706, 6112.358202388774, 571.8713289509827, 586.3842964886852, 601.3595520770366, 602.6835911146683, 603.4659326496082, 3566.6076731559506, 3701.5188025556504, 3789.5073640426567, 3799.3351163546267, 3806.885793426202, 13140.211587304791, 13780.379882905294, 13781.724365512633, 13790.241536715577, 13852.961027922946, 11092.611758588571, 13059.34703264833, 13485.0, 13699.794503082461, 13744.03791734589, 9781.706548803548, 10099.69700908974, 10117.848232276521, 10147.543360548792, 10150.086492215883, 6126.08108783686, 6312.905306420315, 6367.554271200971, 6383.616982981036, 6418.6469744164515, 11985.820212696643, 12058.698532536757, 12086.576969806367, 12250.387480626112, 12278.386080696107, 12419.503219871103, 12573.994080473358, 12609.810852837398, 12692.555760548337, 12735.108542401942, 8566.91433085661, 8862.512561809162, 8944.776380590538, 9072.591733371883, 9229.215516680888, 9943.651972180938, 10005.249606279704, 10089.445080520642, 10095.141912937483, 10107.69676909694, 8391.622376992927, 8400.83198336042, 8481.787955301166, 8520.318374530147, 8555.0, 7727.690892364242, 7769.456138070281, 7835.843283134192, 7848.175941526286, 7886.802829929297, 7552.509086909334, 7717.2282771722375, 7739.806504837424, 7746.883796742941, 7756.185600512091, 5669.886602268014, 5806.912896306474, 5861.531077513703, 5906.675132867562, 5990.221271234712, 5537.778488860562, 5684.8010319638615, 5742.454466825645, 5794.101914203306, 5890.352061273342], "value": 5059.645203449723, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.60802725029714, 387.33765261403, 398.8863173995411, 411.62747713319436, 412.1386302627509, 4958.900821983562, 5806.909512575475, 5982.252218472691, 6064.423879731429, 6223.626582405059, 4903.239997800338, 5243.397009343927, 5970.522358211343, 6075.119107729377, 6084.634921904689, 3944.9211015779665, 4786.0, 4816.0, 4842.080004799094, 4844.903101937959, 4539.818407263706, 4669.929951050737, 4684.391029166203, 4794.328793968847, 4835.395575553056, 4748.987105895513, 4765.594924431428, 4765.880852978668, 4789.952100478986, 4791.976040119795, 4747.430308363018, 4757.405324334458, 4778.0, 4791.784369703371, 4802.951970480285, 3973.8609148679657, 4172.7895852852525, 4248.681348898814, 4263.936040959388, 4270.7864606769535, 4860.684055536379, 5417.8103766367985, 5982.491488223506, 6000.909986350208, 6033.456988870978, 4124.731892426983, 5228.320318358627, 5250.637213254051, 5328.413874473805, 5491.039068163055, 4991.126552853272, 5589.469000444992, 6540.182477190351, 6599.175103112111, 6649.3350664933605, 4088.7751173685438, 4119.814608342632, 4346.739195648272, 4350.129974005212, 4719.5044520325555, 6063.060225664941, 6303.7163327649905, 6650.567713098633, 6918.135233095863, 6930.861382772367, 4488.932666010012, 4848.7090774553635, 4849.75751212438, 4852.636052296021, 4853.538913803183, 4593.517680643485, 4701.059788042337, 4939.950600494021, 4940.036692844861, 4959.528844759742, 4389.18800021997, 4588.6099681526775, 5319.175527793198, 5446.591505637093, 5503.834884953458, 6079.969600151971, 6436.710348034349, 6670.73256081343, 6679.491343343224, 6739.393454589012, 1603.575052611059, 1668.5650340706982, 1678.6403013559056, 1687.8902871313326, 1689.3580439432938, 970.427447805798, 1112.1436493899653, 1157.9594714184964, 1159.5709587452698, 1167.73142177298, 6085.330613632497, 6088.11722300264, 6089.695515224221, 6107.969460152671, 6129.2032035835055, 5331.773692050772, 6767.864642707217, 6775.258617675445, 6792.286809884891, 6801.65991700413, 5504.862378440571, 5732.853429314154, 5800.50695690871, 6083.69581520931, 6122.693865306717, 2829.405824776779, 3427.091820667525, 3588.7977527528046, 3589.587197472272, 3593.514875491775, 6146.815595532141, 6598.736050557924, 6953.756618518328, 7034.467591666996, 7108.502404831612, 5712.914546236202, 6553.246376666649, 6987.161540615159, 6994.950757386433, 7002.824929376807, 5948.988671925783, 6068.998615228438, 6798.456123510206, 6989.623528000504, 7037.437005039585, 6793.89809152873, 6796.694148763218, 6798.796036118924, 6807.557508762113, 6817.965910170417, 6210.944139496387, 6218.657973811484, 6754.054432379569, 6781.6270105144695, 6794.558353706993, 5412.8105516308315, 6017.909731354121, 6279.811605651837, 7087.086486648679, 7126.322999315057, 4257.510386305491, 4374.606285434326, 4478.484974228006, 4480.865574032784, 4492.191405546902, 5687.715614219355, 5824.767009319749, 6315.336889626523, 6440.871182576228, 6567.638779867153, 6544.382247101197, 6581.80254592363, 6604.966975165094, 6616.338366163538, 6627.1716035495565, 5946.0, 6209.2548894133, 6473.838154046187, 6528.388644542221, 6571.915633920349, 4999.500049994971, 6417.582857114273, 6419.711113000019, 6421.486281097595, 6491.48068154537, 6334.714937827901, 6368.87262254743, 6540.705668244846, 6556.3443655635965, 6594.670266486753, 6412.422881940648, 6415.069814876723, 6425.518086143651, 6468.514861385321, 6479.643619600779], "value": 4812.572990199018, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.6851969393311, 724.3517052238246, 743.0860042148157, 745.910490741111, 768.4735955870229, 14635.0, 15532.767008494882, 15533.301001454933, 15561.299741511632, 15608.609784755372, 12761.617151485447, 14017.229052402114, 14678.63303417415, 14945.551633450987, 15309.846901530982, 907.5961197267219, 928.6053427293407, 931.2038207332735, 933.5658918602849, 933.9906600934006, 939.5161491831713, 945.1776954049952, 949.0699114867434, 974.3033730882418, 989.4607438945756, 1023.6059117239879, 1030.9742256443612, 1031.4224034540644, 1032.1433210435357, 1033.7880734449457, 1022.3456987527989, 1023.7338292044085, 1025.3540269630084, 1025.4155131575005, 1027.3938376357985, 755.1844008470838, 756.5536333563224, 757.4924800383701, 758.2379708393084, 758.8482303539314, 15744.606384840356, 16210.513684589363, 16252.0, 16282.267297971619, 16549.83450165495, 14403.135811851322, 14604.050736702187, 14649.257145130148, 14690.559283221413, 15370.077795332316, 11278.605248816335, 11476.540938362456, 11518.654440366803, 11542.884571154349, 11854.449018916483, 2956.3348246644546, 2982.478066338404, 3071.078676397094, 3073.0319949215927, 3074.3543855790313, 108358.0, 109499.0, 111877.0, 111912.0, 112051.75896482024, 10618.840717389245, 11027.779444411068, 11199.0, 11381.544738210545, 11632.418379081013, 24746.876265618557, 24976.250712478653, 25110.246692599252, 25136.74863251344, 25257.0, 7611.467197296247, 7702.422318326148, 7878.527288362717, 7949.801254968556, 7958.482698624571, 4018.65841403484, 4053.2906741320153, 4078.2455245779624, 4180.916381672349, 4186.267403204427, 4095.406166105898, 4121.443605113272, 4201.915961680749, 4202.810873510699, 4369.628581570539, 835.6879698872833, 839.4585492357518, 844.4975239732349, 846.7375113714768, 854.1927878155208, 558.5364147757351, 561.9100943848964, 565.2199964049586, 569.880325131727, 572.4447286132445, 9505.39568345321, 9939.50302484873, 9999.950000249952, 10170.288079834489, 10200.948995254976, 534.156033467121, 570.3127731084033, 578.8697543052864, 588.8704485013291, 597.4413922981939, 3676.9448458273146, 4703.223968045303, 4787.0, 4788.0, 4834.853978246185, 98692.51961220587, 99965.0, 100390.0, 101251.0, 102831.0, 69453.0, 74664.25335746573, 80032.0, 86066.56966715127, 88180.0, 46633.5336646636, 51869.44391668256, 53384.0, 71157.28842711507, 74371.14072148023, 9166.450012999241, 10590.940905909347, 10650.84023739629, 10795.857426770955, 10921.126309895031, 28110.718892811627, 36844.26311473702, 37009.81495092615, 37114.628853712195, 37301.6269837309, 46988.59034228978, 48310.0, 48410.5158948406, 48505.54483365505, 49154.262686059024, 13203.421346225363, 13270.402831872396, 13409.262490563113, 13703.794443083163, 13833.377498012413, 14231.430742770173, 14231.715365692835, 14307.57077287683, 14528.128312301296, 14770.48303309379, 13209.933950330571, 13406.262655554037, 13622.114562553403, 13761.518346857813, 14166.150030998173, 13051.28217948022, 13320.733585328433, 13348.265845378597, 13376.264305462904, 14129.293535323399, 12863.421146048264, 13137.671558210739, 13335.199888006751, 13345.345405133497, 14016.08895421835, 9448.385854919408, 9463.392269818838, 9507.809843802946, 9535.47554884488, 10105.848412273968, 6887.709641011441, 9856.605735770489, 10833.241673082808, 10975.176861735243, 11113.444327783416], "value": 7399.507063951607, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1500.3999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 110.0, 110.0, 110.0, 110.0, 110.0, 119.0, 164.0, 113.0], "value": 116.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 111.0, 110.0, 150.0, 113.0, 111.0, 111.0, 108.0, 132.0, 110.0], "value": 119.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 185.0, 201.0, 207.0, 180.0, 184.0, 161.0, 208.0, 261.0], "value": 195.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 57.0, 60.0, 87.0, 65.0, 56.0, 60.0, 62.0, 78.0, 76.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 70.0, 88.0, 72.0, 95.0, 103.0, 120.0, 104.0, 103.0, 86.0], "value": 92.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 89.0, 87.0, 87.0, 87.0, 89.0, 88.0, 88.0, 88.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 115.0, 151.0, 95.0, 95.0, 96.0, 95.0, 114.0, 152.0], "value": 110.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 83.0, 84.0, 84.0, 85.0, 84.0, 84.0, 86.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 62.0, 62.0, 61.0, 61.0, 64.0, 64.0, 63.0], "value": 62.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 60.0, 58.0, 56.0, 64.0, 57.0, 57.0, 58.0, 57.0, 59.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 85.0, 98.0, 106.0, 108.0, 105.0, 83.0, 83.0, 80.0], "value": 91.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 138.0, 133.0, 142.0, 156.0, 140.0, 130.0, 193.0, 184.0], "value": 149.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 185.0, 186.0, 186.0, 182.0, 181.0, 201.0, 235.0, 234.0, 185.0], "value": 195.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 65.0, 68.0, 69.0, 69.0, 69.0, 68.0, 69.0], "value": 67.8, "unit": "score"}]}]} 08:07:05 INFO - Return code: 0 08:07:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:07:05 ERROR - # TBPL SUCCESS # 08:07:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:07:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:07:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:07:05 INFO - 2017-03-23 08:07:05.410 screenresolution[1646:9866] starting screenresolution argv=screenresolution get 08:07:05 INFO - 2017-03-23 08:07:05.414 screenresolution[1646:9866] Display 0: 1600x1200x32@60 08:07:05 INFO - 2017-03-23 08:07:05.419 screenresolution[1647:9869] starting screenresolution argv=screenresolution list 08:07:05 INFO - Available Modes on Display 0 08:07:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:07:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:07:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:07:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:07:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:07:05 INFO - Intel Iris: 08:07:05 INFO - Chipset Model: Intel Iris 08:07:05 INFO - Type: GPU 08:07:05 INFO - Bus: Built-In 08:07:05 INFO - VRAM (Dynamic, Max): 1536 MB 08:07:05 INFO - Vendor: Intel (0x8086) 08:07:05 INFO - Device ID: 0x0a2e 08:07:05 INFO - Revision ID: 0x0009 08:07:05 INFO - Displays: 08:07:05 INFO - Display: 08:07:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:07:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:07:05 INFO - Display Serial Number: 1600x1200 60 08:07:05 INFO - Main Display: Yes 08:07:05 INFO - Mirror: Off 08:07:05 INFO - Online: Yes 08:07:05 INFO - Rotation: Supported 08:07:05 INFO - Return code: 0 08:07:05 INFO - Running post-action listener: _resource_record_post_action 08:07:05 INFO - [mozharness: 2017-03-23 15:07:05.658469Z] Finished run-tests step (success) 08:07:05 INFO - Running post-run listener: _resource_record_post_run 08:07:05 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 39314432; Write bytes: 513036288; Read time: 380; Write time: 1551 08:07:05 INFO - TinderboxPrint: CPU usage
53.2% 08:07:05 INFO - TinderboxPrint: I/O read bytes / time
39,314,432 / 380 08:07:05 INFO - TinderboxPrint: I/O write bytes / time
513,036,288 / 1,551 08:07:05 INFO - TinderboxPrint: CPU idle
2,255.3 (46.8%) 08:07:05 INFO - TinderboxPrint: CPU system
957.1 (19.9%) 08:07:05 INFO - TinderboxPrint: CPU user
1,605.2 (33.3%) 08:07:05 INFO - TinderboxPrint: Swap in / out
249,851,904 / 0 08:07:05 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 199856640; Write bytes: 193615872; Read time: 15571; Write time: 362 08:07:05 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 38343680; Write bytes: 299608064; Read time: 365; Write time: 1130 08:07:06 INFO - Running post-run listener: _upload_blobber_files 08:07:06 INFO - Blob upload gear active. 08:07:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:07:06 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 08:07:06 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'] 08:07:06 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 08:07:06 INFO - (blobuploader) - INFO - Open directory for files ... 08:07:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:07:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:07:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:07 INFO - (blobuploader) - INFO - Done attempting. 08:07:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:07:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:07:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:08 INFO - (blobuploader) - INFO - Done attempting. 08:07:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:07:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:09 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:07:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:09 INFO - (blobuploader) - INFO - Done attempting. 08:07:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:07:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:07:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:07:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:07:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:07:12 INFO - (blobuploader) - INFO - Done attempting. 08:07:12 INFO - (blobuploader) - INFO - Iteration through files over. 08:07:12 INFO - Return code: 0 08:07:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:07:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:07:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9384596abac6c51fe85ab07cc0e1fb4727365942aac13a52209c0874c19aa255051597509a3229232356ecc105078b03713f0683c96540afdca69e785d10f91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8298fe8d0bcfc717b1af7e92c6b6bc302f303c6c5d3adaf197f2d8e7a40df47d70809e7e708dc2a32de405ce6f29a51dad3ac89d8d0e4cd6909fa892c16ee2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd6c1c652df265d14fa8a01adf33c3ee6eec855c13039a560f9e8889dd4a331cf1881e3e6021b342533d9080f416ad13e75c53b544e743f2722e617b4b7b02f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b65c7fc55f1336edf90f4a82b5c1a1695ddd4e02dd5a9587b40e24101fe1f09b6da4413f68790faf0c8b34b88a4255af0a539e1759839d76aa57f13e23bf4d"} 08:07:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:07:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:07:12 INFO - Contents: 08:07:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9384596abac6c51fe85ab07cc0e1fb4727365942aac13a52209c0874c19aa255051597509a3229232356ecc105078b03713f0683c96540afdca69e785d10f91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8298fe8d0bcfc717b1af7e92c6b6bc302f303c6c5d3adaf197f2d8e7a40df47d70809e7e708dc2a32de405ce6f29a51dad3ac89d8d0e4cd6909fa892c16ee2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd6c1c652df265d14fa8a01adf33c3ee6eec855c13039a560f9e8889dd4a331cf1881e3e6021b342533d9080f416ad13e75c53b544e743f2722e617b4b7b02f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b65c7fc55f1336edf90f4a82b5c1a1695ddd4e02dd5a9587b40e24101fe1f09b6da4413f68790faf0c8b34b88a4255af0a539e1759839d76aa57f13e23bf4d"} 08:07:12 INFO - Running post-run listener: copy_logs_to_upload_dir 08:07:12 INFO - Copying logs to upload dir... 08:07:12 INFO - mkdir: /builds/slave/test/build/upload/logs 08:07:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1290.682746 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 30 secs) (at 2017-03-23 08:07:12.862729) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 08:07:12.865874) ========= 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.HzYYRkaVTR/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.GNBK3eSghX/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/f9384596abac6c51fe85ab07cc0e1fb4727365942aac13a52209c0874c19aa255051597509a3229232356ecc105078b03713f0683c96540afdca69e785d10f91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8298fe8d0bcfc717b1af7e92c6b6bc302f303c6c5d3adaf197f2d8e7a40df47d70809e7e708dc2a32de405ce6f29a51dad3ac89d8d0e4cd6909fa892c16ee2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd6c1c652df265d14fa8a01adf33c3ee6eec855c13039a560f9e8889dd4a331cf1881e3e6021b342533d9080f416ad13e75c53b544e743f2722e617b4b7b02f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b65c7fc55f1336edf90f4a82b5c1a1695ddd4e02dd5a9587b40e24101fe1f09b6da4413f68790faf0c8b34b88a4255af0a539e1759839d76aa57f13e23bf4d"} build_url:https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011022 build_url: 'https://queue.taskcluster.net/v1/task/Ybj7z_TmSaODMe2IBrMJ1A/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f9384596abac6c51fe85ab07cc0e1fb4727365942aac13a52209c0874c19aa255051597509a3229232356ecc105078b03713f0683c96540afdca69e785d10f91", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d8298fe8d0bcfc717b1af7e92c6b6bc302f303c6c5d3adaf197f2d8e7a40df47d70809e7e708dc2a32de405ce6f29a51dad3ac89d8d0e4cd6909fa892c16ee2c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3fd6c1c652df265d14fa8a01adf33c3ee6eec855c13039a560f9e8889dd4a331cf1881e3e6021b342533d9080f416ad13e75c53b544e743f2722e617b4b7b02f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09b65c7fc55f1336edf90f4a82b5c1a1695ddd4e02dd5a9587b40e24101fe1f09b6da4413f68790faf0c8b34b88a4255af0a539e1759839d76aa57f13e23bf4d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 08:07:12.900247) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:07:12.900561) ========= 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.HzYYRkaVTR/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.GNBK3eSghX/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005126 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 08:07:12.948989) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 08:07:12.949299) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 08:07:12.949591) ========= ========= Total master_lag: 0.28 =========