builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0210 starttime: 1487080556.38 results: success (0) buildid: 20170214043845 builduid: 79e4849908364f1fb924d5fa9f617830 revision: 47391e531350873bfccd576b689259ec249aede8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:56.384162) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:56.384620) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:56.384899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:56.414787) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:56.415204) ========= 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.Kg1j13nsM7/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.sHe34nzhqp/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-14 05:55:56-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 12.9M=0.001s 2017-02-14 05:55:56 (12.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.152978 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:56.591592) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:56.591911) ========= 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.Kg1j13nsM7/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.sHe34nzhqp/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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.020999 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:56.643800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 05:55:56.647284) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 47391e531350873bfccd576b689259ec249aede8 --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 47391e531350873bfccd576b689259ec249aede8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Kg1j13nsM7/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.sHe34nzhqp/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-14 05:55:56,731 truncating revision to first 12 chars 2017-02-14 05:55:56,731 Setting DEBUG logging. 2017-02-14 05:55:56,731 attempt 1/10 2017-02-14 05:55:56,731 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/47391e531350?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-14 05:55:58,227 unpacking tar archive at: mozilla-central-47391e531350/testing/mozharness/ program finished with exit code 0 elapsedTime=1.750484 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 05:55:58.424531) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:58.424996) ========= script_repo_revision: 47391e531350873bfccd576b689259ec249aede8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:58.425394) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:58.425699) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-14 05:55:58.445634) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-02-14 05:55:58.446050) ========= /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.Kg1j13nsM7/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.sHe34nzhqp/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:55:58 INFO - MultiFileLogger online at 20170214 05:55:58 in /builds/slave/test 05:55:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:55:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:55:58 INFO - {'append_to_log': False, 05:55:58 INFO - 'base_work_dir': '/builds/slave/test', 05:55:58 INFO - 'blob_upload_branch': 'Firefox', 05:55:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:55:58 INFO - 'branch': 'Firefox', 05:55:58 INFO - 'buildbot_json_path': 'buildprops.json', 05:55:58 INFO - 'config_files': ('talos/mac_config.py',), 05:55:58 INFO - 'default_actions': ('clobber', 05:55:58 INFO - 'read-buildbot-config', 05:55:58 INFO - 'download-and-extract', 05:55:58 INFO - 'populate-webroot', 05:55:58 INFO - 'create-virtualenv', 05:55:58 INFO - 'install', 05:55:58 INFO - 'run-tests'), 05:55:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:55:58 INFO - 'download_minidump_stackwalk': True, 05:55:58 INFO - 'download_symbols': 'ondemand', 05:55:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:55:58 INFO - 'tooltool.py': '/tools/tooltool.py', 05:55:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:55:58 INFO - '/tools/misc-python/virtualenv.py')}, 05:55:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:55:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:55:58 INFO - 'installer_path': 'installer.exe', 05:55:58 INFO - 'log_level': 'info', 05:55:58 INFO - 'log_name': 'talos', 05:55:58 INFO - 'log_to_console': True, 05:55:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:55:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:55:58 INFO - 'opt_config_files': (), 05:55:58 INFO - 'pip_index': False, 05:55:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:55:58 INFO - 'cmd': ('bash', 05:55:58 INFO - '-c', 05:55:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:55:58 INFO - 'enabled': True, 05:55:58 INFO - 'halt_on_failure': False, 05:55:58 INFO - 'name': 'check_screen_resolution'},), 05:55:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:55:58 INFO - 'cmd': ('bash', 05:55:58 INFO - '-c', 05:55:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:55:58 INFO - 'enabled': True, 05:55:58 INFO - 'halt_on_failure': False, 05:55:58 INFO - 'name': 'check_screen_resolution'},), 05:55:58 INFO - 'run_cmd_checks_enabled': True, 05:55:58 INFO - 'sps_profile': False, 05:55:58 INFO - 'sps_profile_interval': 0, 05:55:58 INFO - 'suite': 'dromaeojs', 05:55:58 INFO - 'system_bits': '32', 05:55:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:55:58 INFO - 'title': 't-yosemite-r7-0210', 05:55:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:55:58 INFO - 'use_talos_json': True, 05:55:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:55:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:55:58 INFO - 'work_dir': 'build'} 05:55:58 INFO - [mozharness: 2017-02-14 13:55:58.647880Z] Running clobber step. 05:55:58 INFO - Running pre-action listener: _resource_record_pre_action 05:55:58 INFO - Running main action method: clobber 05:55:58 INFO - rmtree: /builds/slave/test/build 05:55:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:56:00 INFO - Running post-action listener: _resource_record_post_action 05:56:00 INFO - [mozharness: 2017-02-14 13:56:00.473508Z] Finished clobber step (success) 05:56:00 INFO - [mozharness: 2017-02-14 13:56:00.473665Z] Running read-buildbot-config step. 05:56:00 INFO - Running pre-action listener: _resource_record_pre_action 05:56:00 INFO - Running main action method: read_buildbot_config 05:56:00 INFO - Using buildbot properties: 05:56:00 INFO - { 05:56:00 INFO - "project": "", 05:56:00 INFO - "product": "firefox", 05:56:00 INFO - "script_repo_revision": "production", 05:56:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:56:00 INFO - "repository": "", 05:56:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:56:00 INFO - "buildid": "20170214043845", 05:56:00 INFO - "pgo_build": "False", 05:56:00 INFO - "basedir": "/builds/slave/test", 05:56:00 INFO - "buildnumber": 72, 05:56:00 INFO - "slavename": "t-yosemite-r7-0210", 05:56:00 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:56:00 INFO - "platform": "yosemite_r7", 05:56:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:56:00 INFO - "branch": "mozilla-central", 05:56:00 INFO - "repo_path": "mozilla-central", 05:56:00 INFO - "revision": "47391e531350873bfccd576b689259ec249aede8", 05:56:00 INFO - "stage_platform": "macosx64", 05:56:00 INFO - "builduid": "79e4849908364f1fb924d5fa9f617830", 05:56:00 INFO - "slavebuilddir": "test" 05:56:00 INFO - } 05:56:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 05:56:00 INFO - Running post-action listener: _resource_record_post_action 05:56:00 INFO - [mozharness: 2017-02-14 13:56:00.476959Z] Finished read-buildbot-config step (success) 05:56:00 INFO - [mozharness: 2017-02-14 13:56:00.477080Z] Running download-and-extract step. 05:56:00 INFO - Running pre-action listener: _resource_record_pre_action 05:56:00 INFO - Running main action method: download_and_extract 05:56:00 INFO - mkdir: /builds/slave/test/build/tests 05:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:00 INFO - trying https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 05:56:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 05:56:02 INFO - Downloaded 1199 bytes. 05:56:02 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 05:56:02 INFO - Using the following test package requirements: 05:56:02 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:56:02 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:56:02 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 05:56:02 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:56:02 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 05:56:02 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:56:02 INFO - u'jsshell-mac.zip'], 05:56:02 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:56:02 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 05:56:02 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 05:56:02 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:56:02 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 05:56:02 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:56:02 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 05:56:02 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:56:02 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 05:56:02 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 05:56:02 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 05:56:02 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:56:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:56:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:56:02 INFO - Fetch https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:56:03 INFO - Expected file size: 51503961 05:56:03 INFO - Obtained file size: 51503961 05:56:19 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:56:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 05:56:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:56:19 INFO - Fetch https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 05:56:21 INFO - Expected file size: 51503961 05:56:21 INFO - Obtained file size: 51503961 05:56:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 05:56:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:56:36 INFO - Fetch https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 05:56:37 INFO - Expected file size: 14403647 05:56:37 INFO - Obtained file size: 14403647 05:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:38 INFO - trying https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:56:38 INFO - Downloading https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 05:56:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 05:56:40 INFO - Downloaded 70416439 bytes. 05:56:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:56:40 INFO - mkdir: /builds/slave/test/properties 05:56:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:56:40 INFO - Writing to file /builds/slave/test/properties/build_url 05:56:40 INFO - Contents: 05:56:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 05:56:40 INFO - Running post-action listener: _resource_record_post_action 05:56:40 INFO - Running post-action listener: set_extra_try_arguments 05:56:40 INFO - [mozharness: 2017-02-14 13:56:40.738721Z] Finished download-and-extract step (success) 05:56:40 INFO - [mozharness: 2017-02-14 13:56:40.738859Z] Running populate-webroot step. 05:56:40 INFO - Running pre-action listener: _resource_record_pre_action 05:56:40 INFO - Running main action method: populate_webroot 05:56:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:56:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:56:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:56:40 INFO - '--tppagecycles', 05:56:40 INFO - '7'], 05:56:40 INFO - 'tests': ['tsvgm']}}, 05:56:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:56:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:56:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:56:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:56:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:56:40 INFO - 'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:56:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:56:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:56:40 INFO - 'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['damp', 'tps']}, 05:56:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:56:40 INFO - 'tests': ['damp', 'tps']}, 05:56:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['dromaeo_dom']}, 05:56:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:56:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['basic_compositor_video']}, 05:56:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:56:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['a11yr', 05:56:40 INFO - 'ts_paint', 05:56:40 INFO - 'tpaint', 05:56:40 INFO - 'sessionrestore', 05:56:40 INFO - 'sessionrestore_no_auto_restore', 05:56:40 INFO - 'tabpaint']}, 05:56:40 INFO - 'other-e10s': {'tests': ['a11yr', 05:56:40 INFO - 'ts_paint', 05:56:40 INFO - 'tpaint', 05:56:40 INFO - 'sessionrestore', 05:56:40 INFO - 'sessionrestore_no_auto_restore', 05:56:40 INFO - 'tabpaint']}, 05:56:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:56:40 INFO - 'ts_paint', 05:56:40 INFO - 'tpaint', 05:56:40 INFO - 'sessionrestore', 05:56:40 INFO - 'sessionrestore_no_auto_restore', 05:56:40 INFO - 'tabpaint']}, 05:56:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:56:40 INFO - 'ts_paint', 05:56:40 INFO - 'tpaint', 05:56:40 INFO - 'sessionrestore', 05:56:40 INFO - 'sessionrestore_no_auto_restore', 05:56:40 INFO - 'tabpaint']}, 05:56:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['a11yr', 05:56:40 INFO - 'ts_paint', 05:56:40 INFO - 'tpaint', 05:56:40 INFO - 'sessionrestore', 05:56:40 INFO - 'sessionrestore_no_auto_restore', 05:56:40 INFO - 'tabpaint']}, 05:56:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['a11yr', 05:56:40 INFO - 'ts_paint', 05:56:40 INFO - 'tpaint', 05:56:40 INFO - 'sessionrestore', 05:56:40 INFO - 'sessionrestore_no_auto_restore', 05:56:40 INFO - 'tabpaint']}, 05:56:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['tsvgx', 05:56:40 INFO - 'tsvgr_opacity', 05:56:40 INFO - 'tart', 05:56:40 INFO - 'tscrollx', 05:56:40 INFO - 'cart', 05:56:40 INFO - 'tsvg_static']}, 05:56:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:56:40 INFO - 'tsvgr_opacity', 05:56:40 INFO - 'tart', 05:56:40 INFO - 'tscrollx', 05:56:40 INFO - 'cart', 05:56:40 INFO - 'tsvg_static']}, 05:56:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:56:40 INFO - 'talos_options': ['--disable-e10s'], 05:56:40 INFO - 'tests': ['tp5o']}, 05:56:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:56:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:56:40 INFO - 'talos_options': ['--disable-e10s', 05:56:40 INFO - '--xperf_path', 05:56:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:40 INFO - 'tests': ['tp5n']}, 05:56:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:56:40 INFO - 'talos_options': ['--xperf_path', 05:56:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:56:40 INFO - 'tests': ['tp5n']}}, 05:56:40 INFO - 'talos.zip': {'path': '', 05:56:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:56:40 INFO - Running post-action listener: _resource_record_post_action 05:56:40 INFO - [mozharness: 2017-02-14 13:56:40.757972Z] Finished populate-webroot step (success) 05:56:40 INFO - [mozharness: 2017-02-14 13:56:40.758085Z] Running create-virtualenv step. 05:56:40 INFO - Running pre-action listener: _resource_record_pre_action 05:56:40 INFO - Running main action method: create_virtualenv 05:56:40 INFO - Creating virtualenv /builds/slave/test/build/venv 05:56:40 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:56:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:56:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:56:40 INFO - Using real prefix '/tools/python27' 05:56:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:56:41 INFO - Installing distribute.............................................................................................................................................................................................done. 05:56:44 INFO - Installing pip.................done. 05:56:44 INFO - Return code: 0 05:56:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:56:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:56:44 INFO - Reading from file tmpfile_stdout 05:56:44 INFO - Output received: 05:56:44 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:56:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56: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', 'pip>=1.5'] in /builds/slave/test/build 05:56: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 pip>=1.5 05:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:44 INFO - 'HOME': '/Users/cltbld', 05:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:44 INFO - 'LOGNAME': 'cltbld', 05:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:44 INFO - 'MOZ_NO_REMOTE': '1', 05:56:44 INFO - 'NO_EM_RESTART': '1', 05:56:44 INFO - 'PAGER': '/bin/cat', 05:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:44 INFO - 'PWD': '/builds/slave/test', 05:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:44 INFO - 'SHELL': '/bin/bash', 05:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:56:44 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:44 INFO - 'USER': 'cltbld', 05:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:44 INFO - 'XPC_FLAGS': '0x0', 05:56:44 INFO - 'XPC_SERVICE_NAME': '0', 05:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:44 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:56:44 INFO - Cleaning up... 05:56:44 INFO - Return code: 0 05:56:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56: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', '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 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56: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', 'psutil>=3.1.1'] in /builds/slave/test/build 05:56: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 psutil>=3.1.1 05:56:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:56:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:44 INFO - 'HOME': '/Users/cltbld', 05:56:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:44 INFO - 'LOGNAME': 'cltbld', 05:56:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:44 INFO - 'MOZ_NO_REMOTE': '1', 05:56:44 INFO - 'NO_EM_RESTART': '1', 05:56:44 INFO - 'PAGER': '/bin/cat', 05:56:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:44 INFO - 'PWD': '/builds/slave/test', 05:56:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:44 INFO - 'SHELL': '/bin/bash', 05:56:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:56:44 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:56:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:44 INFO - 'USER': 'cltbld', 05:56:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:44 INFO - 'XPC_FLAGS': '0x0', 05:56:44 INFO - 'XPC_SERVICE_NAME': '0', 05:56:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:45 INFO - Downloading/unpacking psutil>=3.1.1 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:56:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:48 INFO - Installing collected packages: psutil 05:56:48 INFO - Running setup.py install for psutil 05:56:48 INFO - building 'psutil._psutil_osx' extension 05:56:48 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:56:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:56:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:56:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:56:49 INFO - building 'psutil._psutil_posix' extension 05:56:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:56:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:56:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:56:49 INFO - ^ 05:56:49 INFO - 1 warning generated. 05:56:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:56:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:56:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:56:49 INFO - Successfully installed psutil 05:56:49 INFO - Cleaning up... 05:56:49 INFO - Return code: 0 05:56:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:49 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 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:56:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:56:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:49 INFO - 'HOME': '/Users/cltbld', 05:56:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:49 INFO - 'LOGNAME': 'cltbld', 05:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:49 INFO - 'MOZ_NO_REMOTE': '1', 05:56:49 INFO - 'NO_EM_RESTART': '1', 05:56:49 INFO - 'PAGER': '/bin/cat', 05:56:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:49 INFO - 'PWD': '/builds/slave/test', 05:56:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:49 INFO - 'SHELL': '/bin/bash', 05:56:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:56:49 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:56:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:49 INFO - 'USER': 'cltbld', 05:56:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:49 INFO - 'XPC_FLAGS': '0x0', 05:56:49 INFO - 'XPC_SERVICE_NAME': '0', 05:56:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:56:52 INFO - Installing collected packages: mozsystemmonitor 05:56:52 INFO - Running setup.py install for mozsystemmonitor 05:56:52 INFO - Successfully installed mozsystemmonitor 05:56:52 INFO - Cleaning up... 05:56:52 INFO - Return code: 0 05:56:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:53 INFO - 'HOME': '/Users/cltbld', 05:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:53 INFO - 'LOGNAME': 'cltbld', 05:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:53 INFO - 'MOZ_NO_REMOTE': '1', 05:56:53 INFO - 'NO_EM_RESTART': '1', 05:56:53 INFO - 'PAGER': '/bin/cat', 05:56:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:53 INFO - 'PWD': '/builds/slave/test', 05:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:53 INFO - 'SHELL': '/bin/bash', 05:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:56:53 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:53 INFO - 'USER': 'cltbld', 05:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:53 INFO - 'XPC_FLAGS': '0x0', 05:56:53 INFO - 'XPC_SERVICE_NAME': '0', 05:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:54 INFO - Downloading/unpacking jsonschema==2.5.1 05:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:56:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56: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 05:56:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:56:57 INFO - warning: no files found matching '*.txt' 05:56:57 INFO - no previously-included directories found matching 'build' 05:56:57 INFO - no previously-included directories found matching 'dist' 05:56:57 INFO - no previously-included directories found matching '.git*' 05:56:57 INFO - Installing collected packages: jsonschema, functools32 05:56:57 INFO - Running setup.py install for functools32 05:56:57 INFO - warning: no files found matching '*.txt' 05:56:57 INFO - no previously-included directories found matching 'build' 05:56:57 INFO - no previously-included directories found matching 'dist' 05:56:57 INFO - no previously-included directories found matching '.git*' 05:56:57 INFO - Successfully installed jsonschema functools32 05:56:57 INFO - Cleaning up... 05:56:57 INFO - Return code: 0 05:56:57 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:57 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 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:56:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:56:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:57 INFO - 'HOME': '/Users/cltbld', 05:56:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:57 INFO - 'LOGNAME': 'cltbld', 05:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:57 INFO - 'MOZ_NO_REMOTE': '1', 05:56:57 INFO - 'NO_EM_RESTART': '1', 05:56:57 INFO - 'PAGER': '/bin/cat', 05:56:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:57 INFO - 'PWD': '/builds/slave/test', 05:56:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:57 INFO - 'SHELL': '/bin/bash', 05:56:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:56:57 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:56:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:57 INFO - 'USER': 'cltbld', 05:56:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:57 INFO - 'XPC_FLAGS': '0x0', 05:56:57 INFO - 'XPC_SERVICE_NAME': '0', 05:56:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:56:57 INFO - Cleaning up... 05:56:57 INFO - Return code: 0 05:56:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:56:57 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 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:56:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:56:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:56:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:56:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:56:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:56:57 INFO - 'HOME': '/Users/cltbld', 05:56:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:56:57 INFO - 'LOGNAME': 'cltbld', 05:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:56:57 INFO - 'MOZ_NO_REMOTE': '1', 05:56:57 INFO - 'NO_EM_RESTART': '1', 05:56:57 INFO - 'PAGER': '/bin/cat', 05:56:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:56:57 INFO - 'PWD': '/builds/slave/test', 05:56:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:56:57 INFO - 'SHELL': '/bin/bash', 05:56:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:56:57 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:56:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:56:57 INFO - 'USER': 'cltbld', 05:56:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:56:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:56:57 INFO - 'XPC_FLAGS': '0x0', 05:56:57 INFO - 'XPC_SERVICE_NAME': '0', 05:56:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:56:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:57:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:57:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:01 INFO - Downloading docopt-0.6.1.tar.gz 05:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:57:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:57:01 INFO - Running setup.py install for blobuploader 05:57:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:57:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:57:01 INFO - Running setup.py install for requests 05:57:02 INFO - Running setup.py install for docopt 05:57:02 INFO - Successfully installed blobuploader requests docopt 05:57:02 INFO - Cleaning up... 05:57:02 INFO - Return code: 0 05:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:02 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 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:02 INFO - 'HOME': '/Users/cltbld', 05:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:02 INFO - 'LOGNAME': 'cltbld', 05:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:02 INFO - 'MOZ_NO_REMOTE': '1', 05:57:02 INFO - 'NO_EM_RESTART': '1', 05:57:02 INFO - 'PAGER': '/bin/cat', 05:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:02 INFO - 'PWD': '/builds/slave/test', 05:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:02 INFO - 'SHELL': '/bin/bash', 05:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:57:02 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:02 INFO - 'USER': 'cltbld', 05:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:02 INFO - 'XPC_FLAGS': '0x0', 05:57:02 INFO - 'XPC_SERVICE_NAME': '0', 05:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:02 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-LNXhdY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:03 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-A3EYGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:03 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-sL7qET-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:03 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-V7ycnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:03 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Xd0gUD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:03 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-gJhDAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:03 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-RJFCld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:03 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-aYeLab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:03 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-HQQi24-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:03 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-F6e1Pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-DTLlyz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-BLX_Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-1nsOuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-w02UhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-72FHXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-kpn0r7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:04 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-2ki5Mq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:57:04 INFO - Running setup.py install for manifestparser 05:57:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:57:04 INFO - Running setup.py install for mozcrash 05:57:05 INFO - Running setup.py install for mozdebug 05:57:05 INFO - Running setup.py install for mozdevice 05:57:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:57:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:57:05 INFO - Running setup.py install for mozfile 05:57:05 INFO - Running setup.py install for mozhttpd 05:57:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:57:05 INFO - Running setup.py install for mozinfo 05:57:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:57:05 INFO - Running setup.py install for mozInstall 05:57:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:57:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:57:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:57:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:57:05 INFO - Running setup.py install for mozleak 05:57:06 INFO - Running setup.py install for mozlog 05:57:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:57:06 INFO - Running setup.py install for moznetwork 05:57:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:57:06 INFO - Running setup.py install for mozprocess 05:57:06 INFO - Running setup.py install for mozprofile 05:57:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:57:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:57:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:57:06 INFO - Running setup.py install for mozrunner 05:57:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:57:06 INFO - Running setup.py install for mozscreenshot 05:57:07 INFO - Running setup.py install for moztest 05:57:07 INFO - Running setup.py install for mozversion 05:57:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:57:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:57:07 INFO - Cleaning up... 05:57:07 INFO - Return code: 0 05:57:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:07 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 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:57:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:57:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:07 INFO - 'HOME': '/Users/cltbld', 05:57:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:07 INFO - 'LOGNAME': 'cltbld', 05:57:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:07 INFO - 'MOZ_NO_REMOTE': '1', 05:57:07 INFO - 'NO_EM_RESTART': '1', 05:57:07 INFO - 'PAGER': '/bin/cat', 05:57:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:07 INFO - 'PWD': '/builds/slave/test', 05:57:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:07 INFO - 'SHELL': '/bin/bash', 05:57:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:57:07 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:57:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:07 INFO - 'USER': 'cltbld', 05:57:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:07 INFO - 'XPC_FLAGS': '0x0', 05:57:07 INFO - 'XPC_SERVICE_NAME': '0', 05:57:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:57:07 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-2UHFi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:57:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:57:07 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-pthv5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:57:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:57:07 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-sXkSLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:57:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:57:07 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-9TtX6x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:57:08 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-VmfHtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:57:08 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-EHa5eY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:57:08 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-gTpOi1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:57:08 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-g7751W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:57:08 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-xjE8Oo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:57:08 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-X3njkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:57:08 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-dE7wNN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:57:08 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-7gYS21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:57:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:57:08 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-krzNqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:57:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-lURfNy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-hYJWmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:57:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-6SvjBS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:57:09 INFO - Running setup.py (path:/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/pip-Vuah9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:57:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:57:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:57:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:57:11 INFO - Downloading blessings-1.6.tar.gz 05:57:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:57:12 INFO - Installing collected packages: blessings 05:57:12 INFO - Running setup.py install for blessings 05:57:12 INFO - Successfully installed blessings 05:57:12 INFO - Cleaning up... 05:57:12 INFO - Return code: 0 05:57:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:12 INFO - Reading from file tmpfile_stdout 05:57:12 INFO - Current package versions: 05:57:12 INFO - blessings == 1.6 05:57:12 INFO - blobuploader == 1.2.4 05:57:12 INFO - docopt == 0.6.1 05:57:12 INFO - functools32 == 3.2.3-2 05:57:12 INFO - jsonschema == 2.5.1 05:57:12 INFO - manifestparser == 1.1 05:57:12 INFO - mozInstall == 1.12 05:57:12 INFO - mozcrash == 1.0 05:57:12 INFO - mozdebug == 0.1 05:57:12 INFO - mozdevice == 0.49 05:57:12 INFO - mozfile == 1.2 05:57:12 INFO - mozhttpd == 0.7 05:57:12 INFO - mozinfo == 0.9 05:57:12 INFO - mozleak == 0.1 05:57:12 INFO - mozlog == 3.4 05:57:12 INFO - moznetwork == 0.27 05:57:12 INFO - mozprocess == 0.24 05:57:12 INFO - mozprofile == 0.28 05:57:12 INFO - mozrunner == 6.13 05:57:12 INFO - mozscreenshot == 0.1 05:57:12 INFO - mozsystemmonitor == 0.3 05:57:12 INFO - moztest == 0.8 05:57:12 INFO - mozversion == 1.4 05:57:12 INFO - psutil == 3.1.1 05:57:12 INFO - requests == 1.2.3 05:57:12 INFO - wsgiref == 0.1.2 05:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:12 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 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:12 INFO - 'HOME': '/Users/cltbld', 05:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:12 INFO - 'LOGNAME': 'cltbld', 05:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:12 INFO - 'MOZ_NO_REMOTE': '1', 05:57:12 INFO - 'NO_EM_RESTART': '1', 05:57:12 INFO - 'PAGER': '/bin/cat', 05:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:12 INFO - 'PWD': '/builds/slave/test', 05:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:12 INFO - 'SHELL': '/bin/bash', 05:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:57:12 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:12 INFO - 'USER': 'cltbld', 05:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:12 INFO - 'XPC_FLAGS': '0x0', 05:57:12 INFO - 'XPC_SERVICE_NAME': '0', 05:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:57:12 INFO - Cleaning up... 05:57:12 INFO - Return code: 0 05:57:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:57:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1021a3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1021a6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa5d1caf040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, '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.Kg1j13nsM7/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.sHe34nzhqp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:57:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:12 INFO - 'HOME': '/Users/cltbld', 05:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:12 INFO - 'LOGNAME': 'cltbld', 05:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:12 INFO - 'MOZ_NO_REMOTE': '1', 05:57:12 INFO - 'NO_EM_RESTART': '1', 05:57:12 INFO - 'PAGER': '/bin/cat', 05:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:12 INFO - 'PWD': '/builds/slave/test', 05:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:12 INFO - 'SHELL': '/bin/bash', 05:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:57:12 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:12 INFO - 'USER': 'cltbld', 05:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:12 INFO - 'XPC_FLAGS': '0x0', 05:57:12 INFO - 'XPC_SERVICE_NAME': '0', 05:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:57:13 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:57:13 INFO - Cleaning up... 05:57:13 INFO - Return code: 0 05:57:13 INFO - Running post-action listener: _resource_record_post_action 05:57:13 INFO - Running post-action listener: _start_resource_monitoring 05:57:13 INFO - Starting resource monitoring. 05:57:13 INFO - [mozharness: 2017-02-14 13:57:13.227252Z] Finished create-virtualenv step (success) 05:57:13 INFO - [mozharness: 2017-02-14 13:57:13.228318Z] Running install step. 05:57:13 INFO - Running pre-action listener: _resource_record_pre_action 05:57:13 INFO - Running main action method: install 05:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:57:13 INFO - Reading from file tmpfile_stdout 05:57:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:57:13 INFO - Reading from file tmpfile_stdout 05:57:13 INFO - Output received: 05:57:13 INFO - Usage: mozinstall [options] installer 05:57:13 INFO - Options: 05:57:13 INFO - -h, --help show this help message and exit 05:57:13 INFO - -d DEST, --destination=DEST 05:57:13 INFO - Directory to install application into. [default: 05:57:13 INFO - "/builds/slave/test"] 05:57:13 INFO - --app=APP Application being installed. [default: firefox] 05:57:13 INFO - mkdir: /builds/slave/test/build/application 05:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:57:35 INFO - Reading from file tmpfile_stdout 05:57:35 INFO - Output received: 05:57:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:57:35 INFO - Running post-action listener: _resource_record_post_action 05:57:35 INFO - [mozharness: 2017-02-14 13:57:35.847039Z] Finished install step (success) 05:57:35 INFO - [mozharness: 2017-02-14 13:57:35.847161Z] Running run-tests step. 05:57:35 INFO - Running pre-action listener: _resource_record_pre_action 05:57:35 INFO - Running main action method: run_tests 05:57:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:57:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:57:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:57:35 INFO - 2017-02-14 05:57:35.860 screenresolution[2176:23174] starting screenresolution argv=screenresolution get 05:57:35 INFO - 2017-02-14 05:57:35.862 screenresolution[2176:23174] Display 0: 1600x1200x32@60 05:57:35 INFO - 2017-02-14 05:57:35.867 screenresolution[2177:23177] starting screenresolution argv=screenresolution list 05:57:35 INFO - Available Modes on Display 0 05:57:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:57:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:57:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:57:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:57:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:57:36 INFO - Intel Iris: 05:57:36 INFO - Chipset Model: Intel Iris 05:57:36 INFO - Type: GPU 05:57:36 INFO - Bus: Built-In 05:57:36 INFO - VRAM (Dynamic, Max): 1536 MB 05:57:36 INFO - Vendor: Intel (0x8086) 05:57:36 INFO - Device ID: 0x0a2e 05:57:36 INFO - Revision ID: 0x0009 05:57:36 INFO - Displays: 05:57:36 INFO - Display: 05:57:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:57:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:57:36 INFO - Display Serial Number: 1600x1200 60 05:57:36 INFO - Main Display: Yes 05:57:36 INFO - Mirror: Off 05:57:36 INFO - Online: Yes 05:57:36 INFO - Rotation: Supported 05:57:36 INFO - Return code: 0 05:57:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:57:36 INFO - Python 2.7.3 05:57:36 INFO - Return code: 0 05:57:36 INFO - grabbing minidump binary from tooltool 05:57: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')]} 05:57:36 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 0x101f81d30>, '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 0x101ea8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101f76be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:57:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:57:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:57:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:57:36 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:57:36 INFO - Return code: 0 05:57:36 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:57:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:57:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:57:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:57:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:57:36 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/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:57:36 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/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0210 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:57:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Kg1j13nsM7/Render', 05:57:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:57:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:57:36 INFO - 'HOME': '/Users/cltbld', 05:57:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:57:36 INFO - 'LOGNAME': 'cltbld', 05:57:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:57:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:57:36 INFO - 'MOZ_NO_REMOTE': '1', 05:57:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:57:36 INFO - 'NO_EM_RESTART': '1', 05:57:36 INFO - 'PAGER': '/bin/cat', 05:57:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:57:36 INFO - 'PWD': '/builds/slave/test', 05:57:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:57:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:57:36 INFO - 'SHELL': '/bin/bash', 05:57:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sHe34nzhqp/Listeners', 05:57:36 INFO - 'TMPDIR': '/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/', 05:57:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:57:36 INFO - 'USER': 'cltbld', 05:57:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:57:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:57:36 INFO - 'XPC_FLAGS': '0x0', 05:57:36 INFO - 'XPC_SERVICE_NAME': '0', 05:57:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:57:36 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/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0210', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:57:36 INFO - mozversion application_buildid: 20170214043845 05:57:36 INFO - mozversion application_changeset: 47391e531350873bfccd576b689259ec249aede8 05:57:36 INFO - mozversion application_display_name: Nightly 05:57:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:57:36 INFO - mozversion application_name: Firefox 05:57:36 INFO - mozversion application_remotingname: firefox 05:57:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:57:36 INFO - mozversion application_vendor: Mozilla 05:57:36 INFO - mozversion application_version: 54.0a1 05:57:36 INFO - mozversion platform_buildid: 20170214043845 05:57:36 INFO - mozversion platform_changeset: 47391e531350873bfccd576b689259ec249aede8 05:57:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:57:36 INFO - mozversion platform_version: 54.0a1 05:57:36 INFO - using testdate: 1487080656 05:57:36 INFO - actual date: 1487080656 05:57:36 INFO - starting webserver on 'localhost:54334' 05:57:36 INFO - SUITE-START | Running 2 tests 05:57:36 INFO - TEST-START | dromaeo_css 05:57:36 INFO - operating with platform_type : mac_ 05:57:36 INFO - Initialising browser for dromaeo_css test... 05:57:36 INFO - TEST-INFO | started process 2187 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpZEnYRb/profile http://localhost:54334/getInfo.html) 05:57:38 INFO - PROCESS | 2187 | __metrics Screen width/height:1600/1200 05:57:38 INFO - PROCESS | 2187 | colorDepth:24 05:57:38 INFO - PROCESS | 2187 | Browser inner width/height: 1024/689 05:57:38 INFO - PROCESS | 2187 | __metrics 05:57:38 INFO - PROCESS | 2187 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:57:38 INFO - PROCESS | 2187 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:57:39 INFO - TEST-INFO | 2187: exit 0 05:57:39 INFO - Browser initialized. 05:57:39 INFO - Running cycle 1/1 for dromaeo_css test... 05:57:39 INFO - TEST-INFO | started process 2189 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmpZEnYRb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:57:51 INFO - PROCESS | 2189 | RSS: Main: 229003264 05:57:51 INFO - PROCESS | 2189 | 06:00:56 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:54334/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54334/tests/dromaeo/cssquery-ext.html) 06:00:58 INFO - PROCESS | 2189 | RSS: Main: 407654400 06:00:58 INFO - PROCESS | 2189 | 06:02:41 INFO - PROCESS | 2189 | ************************* 06:02:41 INFO - PROCESS | 2189 | A coding exception was thrown and uncaught in a Task. 06:02:41 INFO - PROCESS | 2189 | 06:02:41 ERROR - PROCESS | 2189 | Full message: TypeError: NetworkError when attempting to fetch resource. 06:02:41 INFO - PROCESS | 2189 | Full stack: 06:02:41 INFO - PROCESS | 2189 | ************************* 06:04:01 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:54334/tests/dromaeo/cssquery-ext.html (next: http://localhost:54334/tests/dromaeo/cssquery-jquery.html) 06:04:02 INFO - PROCESS | 2189 | RSS: Main: 377634816 06:04:02 INFO - PROCESS | 2189 | 06:07:04 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:54334/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54334/tests/dromaeo/cssquery-mootools.html) 06:07:05 INFO - PROCESS | 2189 | RSS: Main: 365232128 06:07:05 INFO - PROCESS | 2189 | 06:10:08 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:54334/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54334/tests/dromaeo/cssquery-prototype.html) 06:10:08 INFO - PROCESS | 2189 | RSS: Main: 363880448 06:10:08 INFO - PROCESS | 2189 | 06:13:12 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:54334/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54334/tests/dromaeo/cssquery-yui.html) 06:13:12 INFO - PROCESS | 2189 | RSS: Main: 326975488 06:13:12 INFO - PROCESS | 2189 | 06:16:15 INFO - PROCESS | 2189 | Cycle 1(1): loaded http://localhost:54334/tests/dromaeo/cssquery-yui.html (next: http://localhost:54334/tests/dromaeo/cssquery-dojo.html) 06:16:15 INFO - PROCESS | 2189 | RSS: Main: 541077504 06:16:15 INFO - PROCESS | 2189 | 06:16:15 INFO - PROCESS | 2189 | __start_tp_report 06:16:15 INFO - PROCESS | 2189 | _x_x_mozilla_page_load 06:16:15 INFO - PROCESS | 2189 | _x_x_mozilla_page_load_details 06:16:15 INFO - PROCESS | 2189 | |i|pagename|runs| 06:16:15 INFO - PROCESS | 2189 | |0;dojo.html;3282.5896762904636;3294.7199488043516;3311.602607687077;3312.072619666494;3361.0421030006455;5349.652272602279;5484.095124304495;5534.833954981352;5591.692456914873;5660.915086273704;5447.373552041517;5502.449755024496;5507.173923911415;5508.421615730351;5510.559155267579;4205.873823785284;5006.299118123466;5019.4227663818765;5068;5118.846434606968;5043.5208655177885;5080.1617733074;5108.1060814357525;5110.080185566597;5119.0529751996;4303.268444364466;5091.516305950947;5102.36220472441;5113.821016264432;5116.590672746172;5148.845534633967;5169.638125331228;5170.405403378603;5171.120909445403;5177.068127737006;4943.6539442239055;5117.948820511784;5118.872028199325;5124.871878203037;5125.4618265082;5607.7476513556985;5701.828945131611;5710.942890571083;5712.6286791358425;5715.914261286084;5968.22413086296;6086.7565297388055;6116.847078823021;6151.415615516519;6181.629102253879;6022.457978781887;6096.908546371808;6111.166351794787;6138.324784273726;6147.44672979434;5709.200711900337;5714.657120572779;5722.971385143048;5727.4845263926445;5747.281589801275;6197.96901015492;6212.658303793244;6213.130161777355;6215.564910456315;6219.720112594944;5781.710914454345;5843.80202058577;5844;5985.670788106696;5992.131140984533;5277.762500687479;6177.660228687465;6181.567290289727;6193.071039344044;6194.659293738888;5498.285222921075;6138.447539721446;6145.231846019247;6147.385261473817;6147.907781383283;5876.236089308448;6019.398060194033;6025.578209525379;6092.603980741326;6172.629642221391;4784.162771514971;4821.325014497973;4835.443923948791;4842.297866809293;4842.975785121052;4346.521882592912;4360.084382279693;4367.934480982788;4372.7376357418025;4391.253486907233;5610.102383618601;5613.298337707786;5622.184783206494;5634.746436410372;5635.520980716685;5173.948260517422;6096.230158730159;6103.640733310809;6135.417135372132;6141.477974372228;5587.525060369833;5599.7480113394995;5616.0171969905105;5621.819417922282;5629.7185140742795;5359.3032905722785;5364.517193452608;5393.298871146726;5394.91907621386;5410.404855465896;6166.352532983972;6190.969045154746;6201.658908759971;6201.720922558586;6204.5036397089025;5938.257717785277;5993.250843644544;6215.564910456405;6232.314445411092;6243.656598887105;6131.835460087213;6153.015517517176;6157.1072194532435;6161.137440758208;6176.969115154396;6083.543734220039;6094.421030002142;6105.145279660762;6106.084087386927;6136.2943261523715;6032.607880487754;6188.907166392598;6195.690215489298;6199.721012554356;6202.751889924352;5750.166225897138;5786.161006654096;5812.94187058124;5956.8808623828145;6009.489193418433;5497.230387745639;5935.40645935403;6035.758569657164;6051.394860513913;6094.20775299226;5395.568354531707;5403.459654034565;5603.607747457639;5854.677992710442;5862.94137058641;5292.174199901028;5753.05074662676;5825.446582574648;6008.909866352095;6023.156758053964;5736.254286942671;5789.652620842763;5812.94187058141;5814.94185058144;5901.793437229677 06:16:15 INFO - PROCESS | 2189 | |1;ext.html;415.75054967019776;491.2263185482863;493.77039676550396;515.479365840501;546.9206964990079;27078.45843083137;38522.614773852256;39573.60426395735;39667.801660991725;39818.60181398185;39403.40894886579;39797;39805.60194398055;40025;40162.79511614656;9107.08929107089;9302.62789488423;9324.627014919395;9327.067293270686;9333.439993600372;7477.5887326197035;7638.274363935445;11050;11268.042216411615;11295.887041129607;11334.773304533946;11420.942895285512;11425.942870285637;11431.714207144805;11514.884851151464;11314.547418103266;11353.091752659768;11371.601993930173;11378.032867206297;11389.974902258795;7317.707291708379;7481.513701609432;11054.336739795557;11229.382383968878;11499.482523286471;38051;38740.80629596862;38763.41854872179;38783.418248726295;38806.22387552261;3724.398508641283;3728.9627103728885;3731.8880433587037;3753.380692185786;3775.131719704456;28998;29045.273868153465;29181.56227656587;29589;30205.546916796266;3014.716812843777;3039.574459575661;3053.664096949356;3072.846357682107;3192.2179066128947;324737;325140.1228981567;325152;326130;326625.9999999976;45487;56338.718306408206;56687.43312566821;56688;56711.71644141753;45581.31628025582;48935.26597101046;57724.422755771906;57740.42259577435;58228.41771582315;14411.495597654031;14857.777133343008;14869.851301487062;14875.33061012257;14885.92557037208;11567.826482602768;11570.537178512765;11629.418529073513;11635;11635.941820291013;12254.142210045211;14354.712905741826;14393.424263029361;14404.567862964128;14412.495562655256;6886.8622627548175;6906.689198986058;6937.965310173417;6978.581285122909;7002.579845209304;762.6110683551428;797.8125140591957;814.5072231300096;818.7011740714596;849.5667209723085;27735.583966240523;27830.582541261898;27913.720862791517;28085.321994158385;28504.572431413544;979.9510024498746;1000.46475135802;1013.7465633591602;1064.8562444070105;1137.9317240965568;12765.361731913554;14262.144271343544;14564.85435145635;14692.412303507954;14728;504238;569646;581108;581390.093049532;728354;48678;49102.754486228056;49103.508964909895;49125.631155326984;49184.77038074077;1314.4479318686174;1352.5604178641784;1358.4701966233176;1359.57853065548;1371.238962375871;25948.22155335343;26030.828612712095;26056;26099;26500.80746366457;34074;40848.387274191504;40888.79555602203;40905.97735056647;40953.79523102365;417290;420138;420138;420753;420994;19429.708554371977;19556.804431955497;20302.69545956782;20317.59364812725;22544.098236070375;37341.87974360774;38571.2285754289;38979;39512.60487395204;39927;26284;27470.450590987668;31612.841935790173;32812.1796955078;33117.33765324728;31255.84372078125;31515.21211969719;31721.682783171873;32026.51960220552;32495;30877.382452351278;31237.375252495276;31786.52320215245;32329.51505727369;32398;28398.716012839606;28700;28794.568081479214;28845.855770721013;28855.134345969655;18330.90834545819;21473.785262147805;21985;22351.44121396978;22737.545249095256 06:16:15 INFO - PROCESS | 2189 | |2;jquery.html;354.68610279902276;373.2292815336332;381.4811855876008;390.14947414636094;395.69531460775204;12868.806967895478;13570.796438053425;18620.72068918967;20462.386128416154;21386.786132138674;19669.31157409491;21195.68206476904;21509.396241503367;21682;22041.89790510476;5621.915671264935;5943.286805583336;5954.791582294621;5954.9404505955035;5962.433568810956;3774;3984.063745019918;5722.771089156428;6138.324784273726;6439.066335381367;6041.395860413945;6237.875242495147;6518.6740662966895;6519.511036672245;6537.869242615145;5062.974685126569;6444.935550644504;6510.869782604369;6535.607863528204;6547.116139321179;5422.728863556807;5572.5263352615075;5676.886462270772;5690.2887139107615;5690.857728556778;25787.226383208344;26195.607065894026;26205.60691589628;26265;26446.471070578675;3031.4694928387667;3034.4333568792176;3066.4633689104317;3092.8144311341393;3115.081051089934;14698;15152.924235378863;15481.612959675986;16082.19589020556;16208.83791162085;1710.6578684263197;1745.6857765602188;1753.4301352060504;1773.760542326795;1799.5231263715125;115806.42096789462;120923;121470;121848;124249;10680.5047293379;10996.780064398667;11004.889951100387;11044.171687123337;11210.887891121147;12484.563040293546;13120.343982801012;13133.474661013452;13464.596062118153;14082.577522674335;7125.89311160333;8009.759707208793;8175.264226219669;8267.379946504036;8355.498670079693;8097.676092956333;8110.675572977133;8112.18878112184;8291.792705182419;8338.541380224146;6058.818235452944;6590.166228521686;6939.167299924042;6954.513184077066;7003.509754317149;1701.4045084220425;1831.4414103698234;1841.5856432302892;1861.3020117455953;1890.1588792987263;360.7168372827318;373.5759912499333;1027.198784947742;1031.4373723808437;1061.9751939378536;11238.269512481662;11703.473343699554;12075.698107547381;12139.696507587205;12156.33140177281;419.29349046856146;862.344618090256;868.2576397180446;923.7552048707098;931.8043210925646;8719.60761765722;10223.386596804216;10676.51955661997;10803.567857285621;10838.729031774112;612461.0031197494;659550;665999;666001;673976;120351.93841077952;139882.3005884964;141278;142446.2877685605;142877.56693527408;961.8509131084693;1003.3027046202819;1044.8902865199045;1045.0385645206277;1045.383223897904;19484.160498947942;20078.30368646602;20145.183323860612;20180.79819201848;20255.797442025392;44012.67961961018;54799.72600136974;55838;55926;57371.25488059058;80361;81432;81755;82617.76073359024;82682.58658706667;7164.319389657974;7848.725294614661;7893.131755506774;7951.244631760205;8322.625481853453;12239.32683702405;12759.553415630407;12820.743585128432;13243.602691919257;13261.403236854172;11009.61466348674;11068.225224234226;11407.600733974272;11478.598249061242;11482.885171148182;9362.719118426186;10847.481352610483;10919.508622111865;10966.616168434066;11358.034567061892;11191.888081119085;11322.32066076038;11467.483963221508;11629.709257268636;11686;7133.001379806935;7397.482176247611;7434.962825185839;7594.772156835304;7711.151773305044;10888.29226100301;11135.443227838414;11328.376939268419;11381;11491.367974761468 06:16:16 INFO - PROCESS | 2189 | |3;mootools.html;1399.1480048462104;1432.3339647064113;1442.7980082788408;1463.3488097796478;1470.286910848238;8047.91952080479;8135.796605084861;8430.578471076444;8446.408751387406;8467.407281490297;8112.878306825402;8259.710910118147;8276.296514796235;8294.83410331793;8312.418130730835;2020.2020202020194;2241.540484200735;2275.920342788003;2284.417473544252;2293.8279629027807;2001.1995201919203;2245.023414814553;2285.485765702712;2288.0161530541945;2292.323764489471;2240;2248.5615305015526;2267.9319620411416;2272.306946381353;2272.522770218256;2102.4638717127186;2238.563480121377;2257.5146343536217;2261.513774538474;2282.9200977965857;2041.5100375909674;2277.9886100569393;2279.3959600705825;2283.1438210671;2290.6564015397657;8336.333093352578;8403.873941890877;8407.411481196319;8417.368697347723;8436.156384361577;4945.307656928033;5124.333836601218;5130.179171332569;5136.357955255593;5136.486351364833;3125.3280544683003;3236.3689080629288;3400.3709313776785;3443.2424866529323;3445.2937147884873;1168.6085161470917;1169.847919770433;1197.0902114393036;1215.9574414895524;1238.8327575777246;9920.751981200456;10217.029382208679;10243.180545556412;10608.522616482276;10726.088282495997;4472.485664148665;4641.187792136363;4646.83736069236;4665.930011049837;4674.6026587740425;9679.854802177973;9708.077732615531;9709.368891022203;9714.222862171151;9751.658691945748;4544.454665440102;4700.55344742249;5043.873903152377;5213;5265.578753699695;4669.603083737852;4781.760911954389;4799.712017278905;4807;4822.228443449031;3474.2009337852437;3579.713622910161;3632.6912212461707;3747.887563373103;3814.8092595370676;971.223021582731;1091.5427903748425;1107.6289443036674;1111.572044762772;1133.3030186435449;862.377300003983;880.1594477274188;880.366136381804;894.6332003878379;916.4318122763929;5183.455737147545;5301.973490132525;5504.311961004874;5564.8330550083565;5644.068728659725;857.8798968144465;968.4479846487435;998.3710262534556;1000.6447711062614;1013.3970287678967;3544.3442963051916;3595.8381872815785;3734.6452087051684;3741.3265612190066;3773.735838491334;9586.472743999147;9933.503324833873;9933.950330248446;9947.452890091114;9959.850602240973;9805.19545422752;9831.803363932824;9855.11303982645;9865.901340986642;9893;7147.249538798455;7504.549727016397;7515;7538.811529711691;7611.619419028915;5547.667139971614;5644.576656750678;5697.373288938131;5717.7712891485535;5741.282339707536;7263;8223.301019413417;8761.693340733043;8994.280457563511;9115.954420227856;8266.793330166794;8377.790555236168;8614.44006139599;9146.63413463454;9164.404313719588;6264.248290205204;6900.275471075665;7065.929340706527;7152.892706609509;7191.42468602521;7687.5387476751575;7765.301122898966;7776.688932442639;7790.220977902164;7865.724699635485;6927.099477067949;7012.123484564429;7023.7817383659785;7102.4673149512955;7181.281871812777;6796.422304104009;6861.451083913175;6868.450523957971;7091.60996145217;7102.396296314664;5291.708956007303;6296.937030629635;6312.7159277833525;6313.116163736989;6332.556721029668;4851.29656199842;4895.828645997373;4953.801847926043;4983.202687569971;5043.773030213576;4814.8796280093275;4866.90266194667;4905.386826646669;4915.1644220481885;5146.742662866916 06:16:16 INFO - PROCESS | 2189 | |4;prototype.html;320.47762147699245;335.6090154969461;351.51490942499356;358.1279584212443;364.74345878448736;4116.794160291981;5012.6992380457195;5013.69917804932;5151.974240128799;5193.584513238941;4568.771561421924;5107.438181799999;5126.359205099363;5177.508136727014;5177.715225662587;3426.5031570422275;3535.964640353602;4030.9798451007778;4071.8167682454214;4093.9590604094024;3526.5062891195253;3657.104009517672;3673.7428380013275;3934.9606503935024;3949.1904159647347;3150.6061742282213;3893.1045859452342;3912.5109361329833;3923.784191869446;3933.331333673282;3182.8885988990505;3909.550401703798;3933.4493170956234;3956.960430395688;3963.346047902093;2893.943710545657;2994.550817377389;3004.3991201759736;3253.381857447101;3319.717823984964;4396.395315709775;4399.670024748157;4444.31113177458;5005.199168133081;5029.5221953914315;4438.689291749579;4445.888852778674;4449.977750111261;4455.1757924784015;4505.43682039745;4697.577218050357;5069.949300507022;5408.378036525811;5410.431904650034;5461.808836690697;3382.289719158955;3655.104499397638;3687.520622319108;3726;3728.0307120148686;4546.681732278742;4940.456549779521;5430.266913966643;5591.937531868932;5676.687782171979;3489.4416893296952;3665.90022993101;3753.474513568103;3775.301569209705;3785.845317178287;3810.6760925321105;3813.637704418076;3814.599467055975;3817.7900215488417;3819.7708137511836;4259.872203833828;4481.423181670552;4487.820487180542;4491;4495.988402609452;4529.09777893279;5091.9123159504425;5218.547282777089;5313.1764576490705;5514.6691198528215;1216.9513219471298;1230.6431134970937;1239.330761388858;1239.5971309324505;1239.69007748063;776.6796446041751;829.5686243153526;834.6953362022819;854.5769843927171;855.5508358112041;4645.349651048856;4716;4760.881192919661;4819.758812152366;4992.151334273182;5016.122178618727;5330.653507522076;5346.235742205063;5346.946530534645;5349.438308977579;4134.966258435391;4440.178566965122;4476.574725401082;4832.758362081952;4845.030993801254;2631.934201644936;2665.800064995133;2666.600009998477;2712.8199233333166;2798.6781520125446;5372.758225879845;5429.3667571227925;5546.639468434539;5566.860828479239;5628.04527622993;4696.60078893291;4876.439209490883;5099.745012749348;5132.435432102466;5165.405978312467;4766.261229509431;4877.414710234652;4905.77923993414;5328.440513746078;5526.281583394133;4911.140550403594;5346.9465305348;5379.67721936685;5439.225994742789;5443.455654434683;4540.795664195053;4937.8271760488215;5051.393832740095;5148.562372198405;5270.683758974474;5084.720340381315;5261.394939581844;5576.414476480073;5628.549716022791;5670.716464176692;3630.636936306348;3745.438184272381;3757;3778.6410291022307;3791.75353602015;5052.8484145475695;5622.9156562652415;5636.464535869086;5639.477341117793;5656.971715141398;4304.4834619845815;5080.771365288497;5180.61145414103;5444.428335024765;5498.1752737089755;5452.863678408072;5456.644163839131;5458.290422245242;5461.450057462681;5465.590080744039;4565.680402371802;4726.298532528218;5185.673478356399;5351.5451186648015;5367.409584945731;4660.6970546914345;5089.549478398639;5430.429804870431;5445.603934268909;5472.781088756406;4993.550580447777;5022.0960227158;5271.762770675406;5337.146056630921;5382.627430005324 06:16:16 INFO - PROCESS | 2189 | |5;yui.html;696.7317582730648;700.6951975890485;746.3357611725565;810.201951078188;824.27463831828;12757.872421275784;13750.862491375083;13772.586822395331;13832.308384580781;13881.930590347034;13642.795358069638;13738.931305343483;13749.58751237462;13752.724945501084;13754.656133596665;861.2765277167179;874.152072489684;875.3872289397416;876.3514998900831;876.9912300877005;854.5385491834402;855.8844555984956;872.3413822563955;872.5026734761188;873.7728190670408;945.2721404518517;945.7871978804783;947.7677968897596;948.7059011706359;950.5722424908785;943.0475220027787;943.7074506902882;945.3004776465435;945.716285114463;945.8108378324363;699.7515881861967;699.9685014174374;700.0164768500265;700.1772916822713;701.9192792828788;13976.440942362395;14758.778618320734;15073.246337683182;15310.846891531164;15471.845281547265;12601.432935517923;14296.92851535746;14403.279836008263;14431.35058922351;14654.780178297335;11432.485538150802;11508.25196362242;11527.164465402495;11609.941950290195;12005.939970300093;3613.6747692707518;3682.6133256008;3709.647583479565;3709.703223742094;3851.9807400963095;103942.96057039485;104400.47799761029;106212.93787062108;108131.83736325309;111529;10380.792384152275;11226.101911847032;11257.268277562096;11267.323960562393;11513.539458421737;21839.563208735737;23833.165839195546;24357.025718971043;24399.390015249406;24435.511289774462;7665;7728.613569321511;7740;7804.726834560764;8004.559749213733;4083.673306135502;4124.493043534681;4157.91684166315;4169.207850508394;4194.475690538683;3542.557180352456;3594.2452085061905;3661.0115268877253;3677.7609455385314;3679.0802299425145;625.9812205633838;638.8051644248549;665.0987911380107;672.8889733194067;687.6836655138692;618.5299172628835;648.5654611410272;662.9270780214173;687.3641881259815;701.6000879498739;9103.863442048374;9716.409114065702;9796.608135674636;9855;9981.600735970625;614.2874265851591;636.6074088787404;658.5159907468008;677.9627120508321;692.9328833596306;3779.074126838887;4502.144592527409;4648.697834640738;4658.324542941255;4680.321353403738;80832;82481;82885;83458.16541834625;83638.16361836303;73632.63183684048;74279;74430.6278468615;80915;82004.58997704973;69412.65293673499;72063;72120.2787972124;72146.4425742329;72986.63506682432;7320.1215854097845;7667.424943129399;9134.269258459175;9149.77125571866;9291.814163716823;45727.77136114298;46971.29543056789;48321.5167848317;48409.03181936412;49520.25719614136;53550;63080;63988;64962.75186240763;65357.67321163554;10709.57161713554;10887.129029677766;10906.34561926287;10957.83563246536;10962.506687198937;12048.75902481963;12100.19153095775;12123.264476803377;12141.817872731739;12542.498300067895;11281.605143819927;11414.029807466459;11422.200445969034;11663.416829158678;11855.940720296343;11280.2667826591;11330.94334528322;11459;11609.129315301556;11862.22895511789;11203.495842687262;11426.557388442428;11646.825297620373;11731.41342932867;12076.637700868989;9141.725748227564;9391.859122113037;9558.665446709332;9783.608655653694;10183.083522483012;7779.487897019828;9336.31215669793;9410.717678469657;9419.858702119336;9437.150656440679 06:16:16 INFO - PROCESS | 2189 | __end_tp_report 06:16:16 INFO - PROCESS | 2189 | __start_cc_report 06:16:16 INFO - PROCESS | 2189 | _x_x_mozilla_cycle_collect,1795 06:16:16 INFO - PROCESS | 2189 | __end_cc_report 06:16:16 INFO - PROCESS | 2189 | __startTimestamp1487081775989__endTimestamp 06:16:16 INFO - PROCESS | 2189 | 06:16:16 INFO - PROCESS | 2189 | ------- Summary: start ------- 06:16:16 INFO - PROCESS | 2189 | Number of tests: 6 06:16:16 INFO - PROCESS | 2189 | 06:16:16 INFO - PROCESS | 2189 | [#0] dojo.html Cycles:165 Average:5599.10 Median:5736.25 stddev:635.66 (11.1%) stddev-sans-first:611.08 06:16:16 INFO - PROCESS | 2189 | Values: 3282.6 3294.7 3311.6 3312.1 3361.0 5349.7 5484.1 5534.8 5591.7 5660.9 5447.4 5502.4 5507.2 5508.4 5510.6 4205.9 5006.3 5019.4 5068.0 5118.8 5043.5 5080.2 5108.1 5110.1 5119.1 4303.3 5091.5 5102.4 5113.8 5116.6 5148.8 5169.6 5170.4 5171.1 5177.1 4943.7 5117.9 5118.9 5124.9 5125.5 5607.7 5701.8 5710.9 5712.6 5715.9 5968.2 6086.8 6116.8 6151.4 6181.6 6022.5 6096.9 6111.2 6138.3 6147.4 5709.2 5714.7 5723.0 5727.5 5747.3 6198.0 6212.7 6213.1 6215.6 6219.7 5781.7 5843.8 5844.0 5985.7 5992.1 5277.8 6177.7 6181.6 6193.1 6194.7 5498.3 6138.4 6145.2 6147.4 6147.9 5876.2 6019.4 6025.6 6092.6 6172.6 4784.2 4821.3 4835.4 4842.3 4843.0 4346.5 4360.1 4367.9 4372.7 4391.3 5610.1 5613.3 5622.2 5634.7 5635.5 5173.9 6096.2 6103.6 6135.4 6141.5 5587.5 5599.7 5616.0 5621.8 5629.7 5359.3 5364.5 5393.3 5394.9 5410.4 6166.4 6191.0 6201.7 6201.7 6204.5 5938.3 5993.3 6215.6 6232.3 6243.7 6131.8 6153.0 6157.1 6161.1 6177.0 6083.5 6094.4 6105.1 6106.1 6136.3 6032.6 6188.9 6195.7 6199.7 6202.8 5750.2 5786.2 5812.9 5956.9 6009.5 5497.2 5935.4 6035.8 6051.4 6094.2 5395.6 5403.5 5603.6 5854.7 5862.9 5292.2 5753.1 5825.4 6008.9 6023.2 5736.3 5789.7 5812.9 5814.9 5901.8 06:16:16 INFO - PROCESS | 2189 | 06:16:16 INFO - PROCESS | 2189 | [#1] ext.html Cycles:180 Average:57239.53 Median:32178.02 stddev:123439.91 (383.6%) stddev-sans-first:123712.46 06:16:16 INFO - PROCESS | 2189 | Values: 415.8 491.2 493.8 515.5 546.9 27078.5 38522.6 39573.6 39667.8 39818.6 39403.4 39797.0 39805.6 40025.0 40162.8 9107.1 9302.6 9324.6 9327.1 9333.4 7477.6 7638.3 11050.0 11268.0 11295.9 11334.8 11420.9 11425.9 11431.7 11514.9 11314.5 11353.1 11371.6 11378.0 11390.0 7317.7 7481.5 11054.3 11229.4 11499.5 38051.0 38740.8 38763.4 38783.4 38806.2 3724.4 3729.0 3731.9 3753.4 3775.1 28998.0 29045.3 29181.6 29589.0 30205.5 3014.7 3039.6 3053.7 3072.8 3192.2 324737.0 325140.1 325152.0 326130.0 326626.0 45487.0 56338.7 56687.4 56688.0 56711.7 45581.3 48935.3 57724.4 57740.4 58228.4 14411.5 14857.8 14869.9 14875.3 14885.9 11567.8 11570.5 11629.4 11635.0 11635.9 12254.1 14354.7 14393.4 14404.6 14412.5 6886.9 6906.7 6938.0 6978.6 7002.6 762.6 797.8 814.5 818.7 849.6 27735.6 27830.6 27913.7 28085.3 28504.6 980.0 1000.5 1013.7 1064.9 1137.9 12765.4 14262.1 14564.9 14692.4 14728.0 504238.0 569646.0 581108.0 581390.1 728354.0 48678.0 49102.8 49103.5 49125.6 49184.8 1314.4 1352.6 1358.5 1359.6 1371.2 25948.2 26030.8 26056.0 26099.0 26500.8 34074.0 40848.4 40888.8 40906.0 40953.8 417290.0 420138.0 420138.0 420753.0 420994.0 19429.7 19556.8 20302.7 20317.6 22544.1 37341.9 38571.2 38979.0 39512.6 39927.0 26284.0 27470.5 31612.8 32812.2 33117.3 31255.8 31515.2 31721.7 32026.5 32495.0 30877.4 31237.4 31786.5 32329.5 32398.0 28398.7 28700.0 28794.6 28845.9 28855.1 18330.9 21473.8 21985.0 22351.4 22737.5 06:16:16 INFO - PROCESS | 2189 | 06:16:16 INFO - PROCESS | 2189 | [#2] jquery.html Cycles:180 Average:36959.06 Median:25991.42 stddev:109346.46 (420.7%) stddev-sans-first:109618.66 06:16:16 INFO - PROCESS | 2189 | Values: 354.7 373.2 381.5 390.1 395.7 12868.8 13570.8 18620.7 20462.4 21386.8 19669.3 21195.7 21509.4 21682.0 22041.9 5621.9 5943.3 5954.8 5954.9 5962.4 3774.0 3984.1 5722.8 6138.3 6439.1 6041.4 6237.9 6518.7 6519.5 6537.9 5063.0 6444.9 6510.9 6535.6 6547.1 5422.7 5572.5 5676.9 5690.3 5690.9 25787.2 26195.6 26205.6 26265.0 26446.5 3031.5 3034.4 3066.5 3092.8 3115.1 14698.0 15152.9 15481.6 16082.2 16208.8 1710.7 1745.7 1753.4 1773.8 1799.5 115806.4 120923.0 121470.0 121848.0 124249.0 10680.5 10996.8 11004.9 11044.2 11210.9 12484.6 13120.3 13133.5 13464.6 14082.6 7125.9 8009.8 8175.3 8267.4 8355.5 8097.7 8110.7 8112.2 8291.8 8338.5 6058.8 6590.2 6939.2 6954.5 7003.5 1701.4 1831.4 1841.6 1861.3 1890.2 360.7 373.6 1027.2 1031.4 1062.0 11238.3 11703.5 12075.7 12139.7 12156.3 419.3 862.3 868.3 923.8 931.8 8719.6 10223.4 10676.5 10803.6 10838.7 612461.0 659550.0 665999.0 666001.0 673976.0 120351.9 139882.3 141278.0 142446.3 142877.6 961.9 1003.3 1044.9 1045.0 1045.4 19484.2 20078.3 20145.2 20180.8 20255.8 44012.7 54799.7 55838.0 55926.0 57371.3 80361.0 81432.0 81755.0 82617.8 82682.6 7164.3 7848.7 7893.1 7951.2 8322.6 12239.3 12759.6 12820.7 13243.6 13261.4 11009.6 11068.2 11407.6 11478.6 11482.9 9362.7 10847.5 10919.5 10966.6 11358.0 11191.9 11322.3 11467.5 11629.7 11686.0 7133.0 7397.5 7435.0 7594.8 7711.2 10888.3 11135.4 11328.4 11381.0 11491.4 06:16:16 INFO - PROCESS | 2189 | 06:16:16 INFO - PROCESS | 2189 | [#3] mootools.html Cycles:180 Average:5333.68 Median:5278.64 stddev:2904.44 (55.0%) stddev-sans-first:2897.53 06:16:16 INFO - PROCESS | 2189 | Values: 1399.1 1432.3 1442.8 1463.3 1470.3 8047.9 8135.8 8430.6 8446.4 8467.4 8112.9 8259.7 8276.3 8294.8 8312.4 2020.2 2241.5 2275.9 2284.4 2293.8 2001.2 2245.0 2285.5 2288.0 2292.3 2240.0 2248.6 2267.9 2272.3 2272.5 2102.5 2238.6 2257.5 2261.5 2282.9 2041.5 2278.0 2279.4 2283.1 2290.7 8336.3 8403.9 8407.4 8417.4 8436.2 4945.3 5124.3 5130.2 5136.4 5136.5 3125.3 3236.4 3400.4 3443.2 3445.3 1168.6 1169.8 1197.1 1216.0 1238.8 9920.8 10217.0 10243.2 10608.5 10726.1 4472.5 4641.2 4646.8 4665.9 4674.6 9679.9 9708.1 9709.4 9714.2 9751.7 4544.5 4700.6 5043.9 5213.0 5265.6 4669.6 4781.8 4799.7 4807.0 4822.2 3474.2 3579.7 3632.7 3747.9 3814.8 971.2 1091.5 1107.6 1111.6 1133.3 862.4 880.2 880.4 894.6 916.4 5183.5 5302.0 5504.3 5564.8 5644.1 857.9 968.4 998.4 1000.6 1013.4 3544.3 3595.8 3734.6 3741.3 3773.7 9586.5 9933.5 9934.0 9947.5 9959.9 9805.2 9831.8 9855.1 9865.9 9893.0 7147.2 7504.5 7515.0 7538.8 7611.6 5547.7 5644.6 5697.4 5717.8 5741.3 7263.0 8223.3 8761.7 8994.3 9116.0 8266.8 8377.8 8614.4 9146.6 9164.4 6264.2 6900.3 7065.9 7152.9 7191.4 7687.5 7765.3 7776.7 7790.2 7865.7 6927.1 7012.1 7023.8 7102.5 7181.3 6796.4 6861.5 6868.5 7091.6 7102.4 5291.7 6296.9 6312.7 6313.1 6332.6 4851.3 4895.8 4953.8 4983.2 5043.8 4814.9 4866.9 4905.4 4915.2 5146.7 06:16:16 INFO - PROCESS | 2189 | 06:16:16 INFO - PROCESS | 2189 | [#4] prototype.html Cycles:180 Average:4298.84 Median:4793.01 stddev:1307.42 (27.3%) stddev-sans-first:1276.53 06:16:16 INFO - PROCESS | 2189 | Values: 320.5 335.6 351.5 358.1 364.7 4116.8 5012.7 5013.7 5152.0 5193.6 4568.8 5107.4 5126.4 5177.5 5177.7 3426.5 3536.0 4031.0 4071.8 4094.0 3526.5 3657.1 3673.7 3935.0 3949.2 3150.6 3893.1 3912.5 3923.8 3933.3 3182.9 3909.6 3933.4 3957.0 3963.3 2893.9 2994.6 3004.4 3253.4 3319.7 4396.4 4399.7 4444.3 5005.2 5029.5 4438.7 4445.9 4450.0 4455.2 4505.4 4697.6 5069.9 5408.4 5410.4 5461.8 3382.3 3655.1 3687.5 3726.0 3728.0 4546.7 4940.5 5430.3 5591.9 5676.7 3489.4 3665.9 3753.5 3775.3 3785.8 3810.7 3813.6 3814.6 3817.8 3819.8 4259.9 4481.4 4487.8 4491.0 4496.0 4529.1 5091.9 5218.5 5313.2 5514.7 1217.0 1230.6 1239.3 1239.6 1239.7 776.7 829.6 834.7 854.6 855.6 4645.3 4716.0 4760.9 4819.8 4992.2 5016.1 5330.7 5346.2 5346.9 5349.4 4135.0 4440.2 4476.6 4832.8 4845.0 2631.9 2665.8 2666.6 2712.8 2798.7 5372.8 5429.4 5546.6 5566.9 5628.0 4696.6 4876.4 5099.7 5132.4 5165.4 4766.3 4877.4 4905.8 5328.4 5526.3 4911.1 5346.9 5379.7 5439.2 5443.5 4540.8 4937.8 5051.4 5148.6 5270.7 5084.7 5261.4 5576.4 5628.5 5670.7 3630.6 3745.4 3757.0 3778.6 3791.8 5052.8 5622.9 5636.5 5639.5 5657.0 4304.5 5080.8 5180.6 5444.4 5498.2 5452.9 5456.6 5458.3 5461.5 5465.6 4565.7 4726.3 5185.7 5351.5 5367.4 4660.7 5089.5 5430.4 5445.6 5472.8 4993.6 5022.1 5271.8 5337.1 5382.6 06:16:16 INFO - PROCESS | 2189 | 06:16:16 INFO - PROCESS | 2189 | [#5] yui.html Cycles:180 Average:18792.71 Median:51535.13 stddev:26727.93 (51.9%) stddev-sans-first:26768.37 06:16:16 INFO - PROCESS | 2189 | Values: 696.7 700.7 746.3 810.2 824.3 12757.9 13750.9 13772.6 13832.3 13881.9 13642.8 13738.9 13749.6 13752.7 13754.7 861.3 874.2 875.4 876.4 877.0 854.5 855.9 872.3 872.5 873.8 945.3 945.8 947.8 948.7 950.6 943.0 943.7 945.3 945.7 945.8 699.8 700.0 700.0 700.2 701.9 13976.4 14758.8 15073.2 15310.8 15471.8 12601.4 14296.9 14403.3 14431.4 14654.8 11432.5 11508.3 11527.2 11609.9 12005.9 3613.7 3682.6 3709.6 3709.7 3852.0 103943.0 104400.5 106212.9 108131.8 111529.0 10380.8 11226.1 11257.3 11267.3 11513.5 21839.6 23833.2 24357.0 24399.4 24435.5 7665.0 7728.6 7740.0 7804.7 8004.6 4083.7 4124.5 4157.9 4169.2 4194.5 3542.6 3594.2 3661.0 3677.8 3679.1 626.0 638.8 665.1 672.9 687.7 618.5 648.6 662.9 687.4 701.6 9103.9 9716.4 9796.6 9855.0 9981.6 614.3 636.6 658.5 678.0 692.9 3779.1 4502.1 4648.7 4658.3 4680.3 80832.0 82481.0 82885.0 83458.2 83638.2 73632.6 74279.0 74430.6 80915.0 82004.6 69412.7 72063.0 72120.3 72146.4 72986.6 7320.1 7667.4 9134.3 9149.8 9291.8 45727.8 46971.3 48321.5 48409.0 49520.3 53550.0 63080.0 63988.0 64962.8 65357.7 10709.6 10887.1 10906.3 10957.8 10962.5 12048.8 12100.2 12123.3 12141.8 12542.5 11281.6 11414.0 11422.2 11663.4 11855.9 11280.3 11330.9 11459.0 11609.1 11862.2 11203.5 11426.6 11646.8 11731.4 12076.6 9141.7 9391.9 9558.7 9783.6 10183.1 7779.5 9336.3 9410.7 9419.9 9437.2 06:16:16 INFO - PROCESS | 2189 | -------- Summary: end -------- 06:16:16 INFO - PROCESS | 2189 | 06:16:16 INFO - TEST-INFO | 2189: exit 0 06:16:16 INFO - TEST-OK | dromaeo_css | took 1120239ms 06:16:16 INFO - TEST-START | kraken 06:16:16 INFO - operating with platform_type : mac_ 06:16:16 INFO - Initialising browser for kraken test... 06:16:16 INFO - TEST-INFO | started process 2191 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmplTHPEF/profile http://localhost:54334/getInfo.html) 06:16:19 INFO - PROCESS | 2191 | __metrics Screen width/height:1600/1200 06:16:19 INFO - PROCESS | 2191 | colorDepth:24 06:16:19 INFO - PROCESS | 2191 | Browser inner width/height: 1024/689 06:16:19 INFO - PROCESS | 2191 | __metrics 06:16:19 INFO - PROCESS | 2191 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 06:16:19 INFO - PROCESS | 2191 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:16:19 INFO - TEST-INFO | 2191: exit 0 06:16:19 INFO - Browser initialized. 06:16:19 INFO - Running cycle 1/1 for kraken test... 06:16:19 INFO - TEST-INFO | started process 2192 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/T/tmplTHPEF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:16:32 INFO - PROCESS | 2192 | RSS: Main: 229060608 06:16:32 INFO - PROCESS | 2192 | 06:16:34 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54334/tests/kraken/driver.html?testName=audio-beat-detection) 06:16:35 INFO - PROCESS | 2192 | RSS: Main: 289312768 06:16:35 INFO - PROCESS | 2192 | 06:16:38 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54334/tests/kraken/driver.html?testName=audio-dft) 06:16:39 INFO - PROCESS | 2192 | RSS: Main: 292372480 06:16:39 INFO - PROCESS | 2192 | 06:16:42 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54334/tests/kraken/driver.html?testName=audio-fft) 06:16:42 INFO - PROCESS | 2192 | RSS: Main: 382672896 06:16:42 INFO - PROCESS | 2192 | 06:16:45 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54334/tests/kraken/driver.html?testName=audio-oscillator) 06:16:45 INFO - PROCESS | 2192 | RSS: Main: 285499392 06:16:45 INFO - PROCESS | 2192 | 06:16:47 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54334/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:16:48 INFO - PROCESS | 2192 | RSS: Main: 288378880 06:16:48 INFO - PROCESS | 2192 | 06:16:51 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54334/tests/kraken/driver.html?testName=imaging-darkroom) 06:16:51 INFO - PROCESS | 2192 | RSS: Main: 330702848 06:16:51 INFO - PROCESS | 2192 | 06:16:54 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54334/tests/kraken/driver.html?testName=imaging-desaturate) 06:16:55 INFO - PROCESS | 2192 | RSS: Main: 333217792 06:16:55 INFO - PROCESS | 2192 | 06:16:58 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54334/tests/kraken/driver.html?testName=json-parse-financial) 06:16:59 INFO - PROCESS | 2192 | RSS: Main: 328962048 06:16:59 INFO - PROCESS | 2192 | 06:17:00 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54334/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:17:01 INFO - PROCESS | 2192 | RSS: Main: 305975296 06:17:01 INFO - PROCESS | 2192 | 06:17:03 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54334/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:17:03 INFO - PROCESS | 2192 | RSS: Main: 309460992 06:17:03 INFO - PROCESS | 2192 | 06:17:06 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54334/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:17:06 INFO - PROCESS | 2192 | RSS: Main: 311914496 06:17:06 INFO - PROCESS | 2192 | 06:17:09 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:17:10 INFO - PROCESS | 2192 | RSS: Main: 330911744 06:17:10 INFO - PROCESS | 2192 | 06:17:13 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:17:14 INFO - PROCESS | 2192 | RSS: Main: 324108288 06:17:14 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | Cycle 1(1): loaded http://localhost:54334/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54334/tests/kraken/driver.html?testName=ai-astar) 06:17:16 INFO - PROCESS | 2192 | RSS: Main: 368668672 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | __start_tp_report 06:17:16 INFO - PROCESS | 2192 | _x_x_mozilla_page_load 06:17:16 INFO - PROCESS | 2192 | _x_x_mozilla_page_load_details 06:17:16 INFO - PROCESS | 2192 | |i|pagename|runs| 06:17:16 INFO - PROCESS | 2192 | |0;ai-astar;112;113;113;113;114;114;114;113;112;113 06:17:16 INFO - PROCESS | 2192 | |1;audio-beat-detection;148;112;115;151;113;111;110;104;135;114 06:17:16 INFO - PROCESS | 2192 | |2;audio-dft;189;198;185;186;189;185;185;183;187;186 06:17:16 INFO - PROCESS | 2192 | |3;audio-fft;79;51;60;107;88;84;60;62;91;82 06:17:16 INFO - PROCESS | 2192 | |4;audio-oscillator;86;72;89;68;70;70;86;68;68;85 06:17:16 INFO - PROCESS | 2192 | |5;imaging-gaussian-blur;90;89;90;90;90;93;133;109;89;90 06:17:16 INFO - PROCESS | 2192 | |6;imaging-darkroom;96;97;96;97;96;97;96;103;96;95 06:17:16 INFO - PROCESS | 2192 | |7;imaging-desaturate;86;88;88;88;88;86;88;87;100;139 06:17:16 INFO - PROCESS | 2192 | |8;json-parse-financial;62;61;58;61;61;61;60;60;60;61 06:17:16 INFO - PROCESS | 2192 | |9;json-stringify-tinderbox;71;70;65;75;74;69;69;69;68;74 06:17:16 INFO - PROCESS | 2192 | |10;stanford-crypto-aes;94;93;94;93;93;93;92;100;113;109 06:17:16 INFO - PROCESS | 2192 | |11;stanford-crypto-ccm;150;151;145;148;143;134;144;147;180;161 06:17:16 INFO - PROCESS | 2192 | |12;stanford-crypto-pbkdf2;183;184;184;182;184;182;186;188;183;182 06:17:16 INFO - PROCESS | 2192 | |13;stanford-crypto-sha256-iterative;70;69;68;70;68;69;73;74;84;82 06:17:16 INFO - PROCESS | 2192 | __end_tp_report 06:17:16 INFO - PROCESS | 2192 | __start_cc_report 06:17:16 INFO - PROCESS | 2192 | _x_x_mozilla_cycle_collect,2126 06:17:16 INFO - PROCESS | 2192 | __end_cc_report 06:17:16 INFO - PROCESS | 2192 | __startTimestamp1487081836418__endTimestamp 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | ------- Summary: start ------- 06:17:16 INFO - PROCESS | 2192 | Number of tests: 14 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.74 (0.7%) stddev-sans-first:0.67 06:17:16 INFO - PROCESS | 2192 | Values: 112.0 113.0 113.0 113.0 114.0 114.0 114.0 113.0 112.0 113.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#1] audio-beat-detection Cycles:10 Average:121.30 Median:114.50 stddev:16.88 (14.7%) stddev-sans-first:14.88 06:17:16 INFO - PROCESS | 2192 | Values: 148.0 112.0 115.0 151.0 113.0 111.0 110.0 104.0 135.0 114.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#2] audio-dft Cycles:10 Average:187.30 Median:186.50 stddev:4.19 (2.2%) stddev-sans-first:4.40 06:17:16 INFO - PROCESS | 2192 | Values: 189.0 198.0 185.0 186.0 189.0 185.0 185.0 183.0 187.0 186.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#3] audio-fft Cycles:10 Average:76.40 Median:80.50 stddev:17.54 (21.8%) stddev-sans-first:18.58 06:17:16 INFO - PROCESS | 2192 | Values: 79.0 51.0 60.0 107.0 88.0 84.0 60.0 62.0 91.0 82.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:78.50 stddev:9.00 (11.5%) stddev-sans-first:8.82 06:17:16 INFO - PROCESS | 2192 | Values: 86.0 72.0 89.0 68.0 70.0 70.0 86.0 68.0 68.0 85.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:90.00 stddev:14.24 (15.8%) stddev-sans-first:14.92 06:17:16 INFO - PROCESS | 2192 | Values: 90.0 89.0 90.0 90.0 90.0 93.0 133.0 109.0 89.0 90.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#6] imaging-darkroom Cycles:10 Average:96.90 Median:96.00 stddev:2.23 (2.3%) stddev-sans-first:2.35 06:17:16 INFO - PROCESS | 2192 | Values: 96.0 97.0 96.0 97.0 96.0 97.0 96.0 103.0 96.0 95.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:88.00 stddev:16.39 (18.6%) stddev-sans-first:17.14 06:17:16 INFO - PROCESS | 2192 | Values: 86.0 88.0 88.0 88.0 88.0 86.0 88.0 87.0 100.0 139.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#8] json-parse-financial Cycles:10 Average:60.50 Median:61.00 stddev:1.08 (1.8%) stddev-sans-first:1.00 06:17:16 INFO - PROCESS | 2192 | Values: 62.0 61.0 58.0 61.0 61.0 61.0 60.0 60.0 60.0 61.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:3.13 (4.4%) stddev-sans-first:3.32 06:17:16 INFO - PROCESS | 2192 | Values: 71.0 70.0 65.0 75.0 74.0 69.0 69.0 69.0 68.0 74.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#10] stanford-crypto-aes Cycles:10 Average:97.40 Median:93.00 stddev:7.56 (8.1%) stddev-sans-first:7.92 06:17:16 INFO - PROCESS | 2192 | Values: 94.0 93.0 94.0 93.0 93.0 93.0 92.0 100.0 113.0 109.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#11] stanford-crypto-ccm Cycles:10 Average:150.30 Median:149.00 stddev:12.47 (8.4%) stddev-sans-first:13.23 06:17:16 INFO - PROCESS | 2192 | Values: 150.0 151.0 145.0 148.0 143.0 134.0 144.0 147.0 180.0 161.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.80 Median:184.00 stddev:1.93 (1.1%) stddev-sans-first:2.03 06:17:16 INFO - PROCESS | 2192 | Values: 183.0 184.0 184.0 182.0 184.0 182.0 186.0 188.0 183.0 182.0 06:17:16 INFO - PROCESS | 2192 | 06:17:16 INFO - PROCESS | 2192 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.70 Median:71.50 stddev:5.79 (8.1%) stddev-sans-first:6.06 06:17:16 INFO - PROCESS | 2192 | Values: 70.0 69.0 68.0 70.0 68.0 69.0 73.0 74.0 84.0 82.0 06:17:16 INFO - PROCESS | 2192 | -------- Summary: end -------- 06:17:16 INFO - PROCESS | 2192 | 06:17:17 INFO - TEST-INFO | 2192: exit 0 06:17:17 INFO - TEST-OK | kraken | took 60811ms 06:17:17 INFO - SUITE-END | took 1181s 06:17:17 INFO - Completed test suite (00:19:41) 06:17:17 INFO - javascript benchmark 06:17:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6974.423011127275, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3282.5896762904636, 3294.7199488043516, 3311.602607687077, 3312.072619666494, 3361.0421030006455, 5349.652272602279, 5484.095124304495, 5534.833954981352, 5591.692456914873, 5660.915086273704, 5447.373552041517, 5502.449755024496, 5507.173923911415, 5508.421615730351, 5510.559155267579, 4205.873823785284, 5006.299118123466, 5019.4227663818765, 5068.0, 5118.846434606968, 5043.5208655177885, 5080.1617733074, 5108.1060814357525, 5110.080185566597, 5119.0529751996, 4303.268444364466, 5091.516305950947, 5102.36220472441, 5113.821016264432, 5116.590672746172, 5148.845534633967, 5169.638125331228, 5170.405403378603, 5171.120909445403, 5177.068127737006, 4943.6539442239055, 5117.948820511784, 5118.872028199325, 5124.871878203037, 5125.4618265082, 5607.7476513556985, 5701.828945131611, 5710.942890571083, 5712.6286791358425, 5715.914261286084, 5968.22413086296, 6086.7565297388055, 6116.847078823021, 6151.415615516519, 6181.629102253879, 6022.457978781887, 6096.908546371808, 6111.166351794787, 6138.324784273726, 6147.44672979434, 5709.200711900337, 5714.657120572779, 5722.971385143048, 5727.4845263926445, 5747.281589801275, 6197.96901015492, 6212.658303793244, 6213.130161777355, 6215.564910456315, 6219.720112594944, 5781.710914454345, 5843.80202058577, 5844.0, 5985.670788106696, 5992.131140984533, 5277.762500687479, 6177.660228687465, 6181.567290289727, 6193.071039344044, 6194.659293738888, 5498.285222921075, 6138.447539721446, 6145.231846019247, 6147.385261473817, 6147.907781383283, 5876.236089308448, 6019.398060194033, 6025.578209525379, 6092.603980741326, 6172.629642221391, 4784.162771514971, 4821.325014497973, 4835.443923948791, 4842.297866809293, 4842.975785121052, 4346.521882592912, 4360.084382279693, 4367.934480982788, 4372.7376357418025, 4391.253486907233, 5610.102383618601, 5613.298337707786, 5622.184783206494, 5634.746436410372, 5635.520980716685, 5173.948260517422, 6096.230158730159, 6103.640733310809, 6135.417135372132, 6141.477974372228, 5587.525060369833, 5599.7480113394995, 5616.0171969905105, 5621.819417922282, 5629.7185140742795, 5359.3032905722785, 5364.517193452608, 5393.298871146726, 5394.91907621386, 5410.404855465896, 6166.352532983972, 6190.969045154746, 6201.658908759971, 6201.720922558586, 6204.5036397089025, 5938.257717785277, 5993.250843644544, 6215.564910456405, 6232.314445411092, 6243.656598887105, 6131.835460087213, 6153.015517517176, 6157.1072194532435, 6161.137440758208, 6176.969115154396, 6083.543734220039, 6094.421030002142, 6105.145279660762, 6106.084087386927, 6136.2943261523715, 6032.607880487754, 6188.907166392598, 6195.690215489298, 6199.721012554356, 6202.751889924352, 5750.166225897138, 5786.161006654096, 5812.94187058124, 5956.8808623828145, 6009.489193418433, 5497.230387745639, 5935.40645935403, 6035.758569657164, 6051.394860513913, 6094.20775299226, 5395.568354531707, 5403.459654034565, 5603.607747457639, 5854.677992710442, 5862.94137058641, 5292.174199901028, 5753.05074662676, 5825.446582574648, 6008.909866352095, 6023.156758053964, 5736.254286942671, 5789.652620842763, 5812.94187058141, 5814.94185058144, 5901.793437229677], "value": 5559.202357847491, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [415.75054967019776, 491.2263185482863, 493.77039676550396, 515.479365840501, 546.9206964990079, 27078.45843083137, 38522.614773852256, 39573.60426395735, 39667.801660991725, 39818.60181398185, 39403.40894886579, 39797.0, 39805.60194398055, 40025.0, 40162.79511614656, 9107.08929107089, 9302.62789488423, 9324.627014919395, 9327.067293270686, 9333.439993600372, 7477.5887326197035, 7638.274363935445, 11050.0, 11268.042216411615, 11295.887041129607, 11334.773304533946, 11420.942895285512, 11425.942870285637, 11431.714207144805, 11514.884851151464, 11314.547418103266, 11353.091752659768, 11371.601993930173, 11378.032867206297, 11389.974902258795, 7317.707291708379, 7481.513701609432, 11054.336739795557, 11229.382383968878, 11499.482523286471, 38051.0, 38740.80629596862, 38763.41854872179, 38783.418248726295, 38806.22387552261, 3724.398508641283, 3728.9627103728885, 3731.8880433587037, 3753.380692185786, 3775.131719704456, 28998.0, 29045.273868153465, 29181.56227656587, 29589.0, 30205.546916796266, 3014.716812843777, 3039.574459575661, 3053.664096949356, 3072.846357682107, 3192.2179066128947, 324737.0, 325140.1228981567, 325152.0, 326130.0, 326625.9999999976, 45487.0, 56338.718306408206, 56687.43312566821, 56688.0, 56711.71644141753, 45581.31628025582, 48935.26597101046, 57724.422755771906, 57740.42259577435, 58228.41771582315, 14411.495597654031, 14857.777133343008, 14869.851301487062, 14875.33061012257, 14885.92557037208, 11567.826482602768, 11570.537178512765, 11629.418529073513, 11635.0, 11635.941820291013, 12254.142210045211, 14354.712905741826, 14393.424263029361, 14404.567862964128, 14412.495562655256, 6886.8622627548175, 6906.689198986058, 6937.965310173417, 6978.581285122909, 7002.579845209304, 762.6110683551428, 797.8125140591957, 814.5072231300096, 818.7011740714596, 849.5667209723085, 27735.583966240523, 27830.582541261898, 27913.720862791517, 28085.321994158385, 28504.572431413544, 979.9510024498746, 1000.46475135802, 1013.7465633591602, 1064.8562444070105, 1137.9317240965568, 12765.361731913554, 14262.144271343544, 14564.85435145635, 14692.412303507954, 14728.0, 504238.0, 569646.0, 581108.0, 581390.093049532, 728354.0, 48678.0, 49102.754486228056, 49103.508964909895, 49125.631155326984, 49184.77038074077, 1314.4479318686174, 1352.5604178641784, 1358.4701966233176, 1359.57853065548, 1371.238962375871, 25948.22155335343, 26030.828612712095, 26056.0, 26099.0, 26500.80746366457, 34074.0, 40848.387274191504, 40888.79555602203, 40905.97735056647, 40953.79523102365, 417290.0, 420138.0, 420138.0, 420753.0, 420994.0, 19429.708554371977, 19556.804431955497, 20302.69545956782, 20317.59364812725, 22544.098236070375, 37341.87974360774, 38571.2285754289, 38979.0, 39512.60487395204, 39927.0, 26284.0, 27470.450590987668, 31612.841935790173, 32812.1796955078, 33117.33765324728, 31255.84372078125, 31515.21211969719, 31721.682783171873, 32026.51960220552, 32495.0, 30877.382452351278, 31237.375252495276, 31786.52320215245, 32329.51505727369, 32398.0, 28398.716012839606, 28700.0, 28794.568081479214, 28845.855770721013, 28855.134345969655, 18330.90834545819, 21473.785262147805, 21985.0, 22351.44121396978, 22737.545249095256], "value": 17968.936308986093, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.68610279902276, 373.2292815336332, 381.4811855876008, 390.14947414636094, 395.69531460775204, 12868.806967895478, 13570.796438053425, 18620.72068918967, 20462.386128416154, 21386.786132138674, 19669.31157409491, 21195.68206476904, 21509.396241503367, 21682.0, 22041.89790510476, 5621.915671264935, 5943.286805583336, 5954.791582294621, 5954.9404505955035, 5962.433568810956, 3774.0, 3984.063745019918, 5722.771089156428, 6138.324784273726, 6439.066335381367, 6041.395860413945, 6237.875242495147, 6518.6740662966895, 6519.511036672245, 6537.869242615145, 5062.974685126569, 6444.935550644504, 6510.869782604369, 6535.607863528204, 6547.116139321179, 5422.728863556807, 5572.5263352615075, 5676.886462270772, 5690.2887139107615, 5690.857728556778, 25787.226383208344, 26195.607065894026, 26205.60691589628, 26265.0, 26446.471070578675, 3031.4694928387667, 3034.4333568792176, 3066.4633689104317, 3092.8144311341393, 3115.081051089934, 14698.0, 15152.924235378863, 15481.612959675986, 16082.19589020556, 16208.83791162085, 1710.6578684263197, 1745.6857765602188, 1753.4301352060504, 1773.760542326795, 1799.5231263715125, 115806.42096789462, 120923.0, 121470.0, 121848.0, 124249.0, 10680.5047293379, 10996.780064398667, 11004.889951100387, 11044.171687123337, 11210.887891121147, 12484.563040293546, 13120.343982801012, 13133.474661013452, 13464.596062118153, 14082.577522674335, 7125.89311160333, 8009.759707208793, 8175.264226219669, 8267.379946504036, 8355.498670079693, 8097.676092956333, 8110.675572977133, 8112.18878112184, 8291.792705182419, 8338.541380224146, 6058.818235452944, 6590.166228521686, 6939.167299924042, 6954.513184077066, 7003.509754317149, 1701.4045084220425, 1831.4414103698234, 1841.5856432302892, 1861.3020117455953, 1890.1588792987263, 360.7168372827318, 373.5759912499333, 1027.198784947742, 1031.4373723808437, 1061.9751939378536, 11238.269512481662, 11703.473343699554, 12075.698107547381, 12139.696507587205, 12156.33140177281, 419.29349046856146, 862.344618090256, 868.2576397180446, 923.7552048707098, 931.8043210925646, 8719.60761765722, 10223.386596804216, 10676.51955661997, 10803.567857285621, 10838.729031774112, 612461.0031197494, 659550.0, 665999.0, 666001.0, 673976.0, 120351.93841077952, 139882.3005884964, 141278.0, 142446.2877685605, 142877.56693527408, 961.8509131084693, 1003.3027046202819, 1044.8902865199045, 1045.0385645206277, 1045.383223897904, 19484.160498947942, 20078.30368646602, 20145.183323860612, 20180.79819201848, 20255.797442025392, 44012.67961961018, 54799.72600136974, 55838.0, 55926.0, 57371.25488059058, 80361.0, 81432.0, 81755.0, 82617.76073359024, 82682.58658706667, 7164.319389657974, 7848.725294614661, 7893.131755506774, 7951.244631760205, 8322.625481853453, 12239.32683702405, 12759.553415630407, 12820.743585128432, 13243.602691919257, 13261.403236854172, 11009.61466348674, 11068.225224234226, 11407.600733974272, 11478.598249061242, 11482.885171148182, 9362.719118426186, 10847.481352610483, 10919.508622111865, 10966.616168434066, 11358.034567061892, 11191.888081119085, 11322.32066076038, 11467.483963221508, 11629.709257268636, 11686.0, 7133.001379806935, 7397.482176247611, 7434.962825185839, 7594.772156835304, 7711.151773305044, 10888.29226100301, 11135.443227838414, 11328.376939268419, 11381.0, 11491.367974761468], "value": 9575.616392904782, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.1480048462104, 1432.3339647064113, 1442.7980082788408, 1463.3488097796478, 1470.286910848238, 8047.91952080479, 8135.796605084861, 8430.578471076444, 8446.408751387406, 8467.407281490297, 8112.878306825402, 8259.710910118147, 8276.296514796235, 8294.83410331793, 8312.418130730835, 2020.2020202020194, 2241.540484200735, 2275.920342788003, 2284.417473544252, 2293.8279629027807, 2001.1995201919203, 2245.023414814553, 2285.485765702712, 2288.0161530541945, 2292.323764489471, 2240.0, 2248.5615305015526, 2267.9319620411416, 2272.306946381353, 2272.522770218256, 2102.4638717127186, 2238.563480121377, 2257.5146343536217, 2261.513774538474, 2282.9200977965857, 2041.5100375909674, 2277.9886100569393, 2279.3959600705825, 2283.1438210671, 2290.6564015397657, 8336.333093352578, 8403.873941890877, 8407.411481196319, 8417.368697347723, 8436.156384361577, 4945.307656928033, 5124.333836601218, 5130.179171332569, 5136.357955255593, 5136.486351364833, 3125.3280544683003, 3236.3689080629288, 3400.3709313776785, 3443.2424866529323, 3445.2937147884873, 1168.6085161470917, 1169.847919770433, 1197.0902114393036, 1215.9574414895524, 1238.8327575777246, 9920.751981200456, 10217.029382208679, 10243.180545556412, 10608.522616482276, 10726.088282495997, 4472.485664148665, 4641.187792136363, 4646.83736069236, 4665.930011049837, 4674.6026587740425, 9679.854802177973, 9708.077732615531, 9709.368891022203, 9714.222862171151, 9751.658691945748, 4544.454665440102, 4700.55344742249, 5043.873903152377, 5213.0, 5265.578753699695, 4669.603083737852, 4781.760911954389, 4799.712017278905, 4807.0, 4822.228443449031, 3474.2009337852437, 3579.713622910161, 3632.6912212461707, 3747.887563373103, 3814.8092595370676, 971.223021582731, 1091.5427903748425, 1107.6289443036674, 1111.572044762772, 1133.3030186435449, 862.377300003983, 880.1594477274188, 880.366136381804, 894.6332003878379, 916.4318122763929, 5183.455737147545, 5301.973490132525, 5504.311961004874, 5564.8330550083565, 5644.068728659725, 857.8798968144465, 968.4479846487435, 998.3710262534556, 1000.6447711062614, 1013.3970287678967, 3544.3442963051916, 3595.8381872815785, 3734.6452087051684, 3741.3265612190066, 3773.735838491334, 9586.472743999147, 9933.503324833873, 9933.950330248446, 9947.452890091114, 9959.850602240973, 9805.19545422752, 9831.803363932824, 9855.11303982645, 9865.901340986642, 9893.0, 7147.249538798455, 7504.549727016397, 7515.0, 7538.811529711691, 7611.619419028915, 5547.667139971614, 5644.576656750678, 5697.373288938131, 5717.7712891485535, 5741.282339707536, 7263.0, 8223.301019413417, 8761.693340733043, 8994.280457563511, 9115.954420227856, 8266.793330166794, 8377.790555236168, 8614.44006139599, 9146.63413463454, 9164.404313719588, 6264.248290205204, 6900.275471075665, 7065.929340706527, 7152.892706609509, 7191.42468602521, 7687.5387476751575, 7765.301122898966, 7776.688932442639, 7790.220977902164, 7865.724699635485, 6927.099477067949, 7012.123484564429, 7023.7817383659785, 7102.4673149512955, 7181.281871812777, 6796.422304104009, 6861.451083913175, 6868.450523957971, 7091.60996145217, 7102.396296314664, 5291.708956007303, 6296.937030629635, 6312.7159277833525, 6313.116163736989, 6332.556721029668, 4851.29656199842, 4895.828645997373, 4953.801847926043, 4983.202687569971, 5043.773030213576, 4814.8796280093275, 4866.90266194667, 4905.386826646669, 4915.1644220481885, 5146.742662866916], "value": 4332.272438987328, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [320.47762147699245, 335.6090154969461, 351.51490942499356, 358.1279584212443, 364.74345878448736, 4116.794160291981, 5012.6992380457195, 5013.69917804932, 5151.974240128799, 5193.584513238941, 4568.771561421924, 5107.438181799999, 5126.359205099363, 5177.508136727014, 5177.715225662587, 3426.5031570422275, 3535.964640353602, 4030.9798451007778, 4071.8167682454214, 4093.9590604094024, 3526.5062891195253, 3657.104009517672, 3673.7428380013275, 3934.9606503935024, 3949.1904159647347, 3150.6061742282213, 3893.1045859452342, 3912.5109361329833, 3923.784191869446, 3933.331333673282, 3182.8885988990505, 3909.550401703798, 3933.4493170956234, 3956.960430395688, 3963.346047902093, 2893.943710545657, 2994.550817377389, 3004.3991201759736, 3253.381857447101, 3319.717823984964, 4396.395315709775, 4399.670024748157, 4444.31113177458, 5005.199168133081, 5029.5221953914315, 4438.689291749579, 4445.888852778674, 4449.977750111261, 4455.1757924784015, 4505.43682039745, 4697.577218050357, 5069.949300507022, 5408.378036525811, 5410.431904650034, 5461.808836690697, 3382.289719158955, 3655.104499397638, 3687.520622319108, 3726.0, 3728.0307120148686, 4546.681732278742, 4940.456549779521, 5430.266913966643, 5591.937531868932, 5676.687782171979, 3489.4416893296952, 3665.90022993101, 3753.474513568103, 3775.301569209705, 3785.845317178287, 3810.6760925321105, 3813.637704418076, 3814.599467055975, 3817.7900215488417, 3819.7708137511836, 4259.872203833828, 4481.423181670552, 4487.820487180542, 4491.0, 4495.988402609452, 4529.09777893279, 5091.9123159504425, 5218.547282777089, 5313.1764576490705, 5514.6691198528215, 1216.9513219471298, 1230.6431134970937, 1239.330761388858, 1239.5971309324505, 1239.69007748063, 776.6796446041751, 829.5686243153526, 834.6953362022819, 854.5769843927171, 855.5508358112041, 4645.349651048856, 4716.0, 4760.881192919661, 4819.758812152366, 4992.151334273182, 5016.122178618727, 5330.653507522076, 5346.235742205063, 5346.946530534645, 5349.438308977579, 4134.966258435391, 4440.178566965122, 4476.574725401082, 4832.758362081952, 4845.030993801254, 2631.934201644936, 2665.800064995133, 2666.600009998477, 2712.8199233333166, 2798.6781520125446, 5372.758225879845, 5429.3667571227925, 5546.639468434539, 5566.860828479239, 5628.04527622993, 4696.60078893291, 4876.439209490883, 5099.745012749348, 5132.435432102466, 5165.405978312467, 4766.261229509431, 4877.414710234652, 4905.77923993414, 5328.440513746078, 5526.281583394133, 4911.140550403594, 5346.9465305348, 5379.67721936685, 5439.225994742789, 5443.455654434683, 4540.795664195053, 4937.8271760488215, 5051.393832740095, 5148.562372198405, 5270.683758974474, 5084.720340381315, 5261.394939581844, 5576.414476480073, 5628.549716022791, 5670.716464176692, 3630.636936306348, 3745.438184272381, 3757.0, 3778.6410291022307, 3791.75353602015, 5052.8484145475695, 5622.9156562652415, 5636.464535869086, 5639.477341117793, 5656.971715141398, 4304.4834619845815, 5080.771365288497, 5180.61145414103, 5444.428335024765, 5498.1752737089755, 5452.863678408072, 5456.644163839131, 5458.290422245242, 5461.450057462681, 5465.590080744039, 4565.680402371802, 4726.298532528218, 5185.673478356399, 5351.5451186648015, 5367.409584945731, 4660.6970546914345, 5089.549478398639, 5430.429804870431, 5445.603934268909, 5472.781088756406, 4993.550580447777, 5022.0960227158, 5271.762770675406, 5337.146056630921, 5382.627430005324], "value": 3894.374996724954, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.7317582730648, 700.6951975890485, 746.3357611725565, 810.201951078188, 824.27463831828, 12757.872421275784, 13750.862491375083, 13772.586822395331, 13832.308384580781, 13881.930590347034, 13642.795358069638, 13738.931305343483, 13749.58751237462, 13752.724945501084, 13754.656133596665, 861.2765277167179, 874.152072489684, 875.3872289397416, 876.3514998900831, 876.9912300877005, 854.5385491834402, 855.8844555984956, 872.3413822563955, 872.5026734761188, 873.7728190670408, 945.2721404518517, 945.7871978804783, 947.7677968897596, 948.7059011706359, 950.5722424908785, 943.0475220027787, 943.7074506902882, 945.3004776465435, 945.716285114463, 945.8108378324363, 699.7515881861967, 699.9685014174374, 700.0164768500265, 700.1772916822713, 701.9192792828788, 13976.440942362395, 14758.778618320734, 15073.246337683182, 15310.846891531164, 15471.845281547265, 12601.432935517923, 14296.92851535746, 14403.279836008263, 14431.35058922351, 14654.780178297335, 11432.485538150802, 11508.25196362242, 11527.164465402495, 11609.941950290195, 12005.939970300093, 3613.6747692707518, 3682.6133256008, 3709.647583479565, 3709.703223742094, 3851.9807400963095, 103942.96057039485, 104400.47799761029, 106212.93787062108, 108131.83736325309, 111529.0, 10380.792384152275, 11226.101911847032, 11257.268277562096, 11267.323960562393, 11513.539458421737, 21839.563208735737, 23833.165839195546, 24357.025718971043, 24399.390015249406, 24435.511289774462, 7665.0, 7728.613569321511, 7740.0, 7804.726834560764, 8004.559749213733, 4083.673306135502, 4124.493043534681, 4157.91684166315, 4169.207850508394, 4194.475690538683, 3542.557180352456, 3594.2452085061905, 3661.0115268877253, 3677.7609455385314, 3679.0802299425145, 625.9812205633838, 638.8051644248549, 665.0987911380107, 672.8889733194067, 687.6836655138692, 618.5299172628835, 648.5654611410272, 662.9270780214173, 687.3641881259815, 701.6000879498739, 9103.863442048374, 9716.409114065702, 9796.608135674636, 9855.0, 9981.600735970625, 614.2874265851591, 636.6074088787404, 658.5159907468008, 677.9627120508321, 692.9328833596306, 3779.074126838887, 4502.144592527409, 4648.697834640738, 4658.324542941255, 4680.321353403738, 80832.0, 82481.0, 82885.0, 83458.16541834625, 83638.16361836303, 73632.63183684048, 74279.0, 74430.6278468615, 80915.0, 82004.58997704973, 69412.65293673499, 72063.0, 72120.2787972124, 72146.4425742329, 72986.63506682432, 7320.1215854097845, 7667.424943129399, 9134.269258459175, 9149.77125571866, 9291.814163716823, 45727.77136114298, 46971.29543056789, 48321.5167848317, 48409.03181936412, 49520.25719614136, 53550.0, 63080.0, 63988.0, 64962.75186240763, 65357.67321163554, 10709.57161713554, 10887.129029677766, 10906.34561926287, 10957.83563246536, 10962.506687198937, 12048.75902481963, 12100.19153095775, 12123.264476803377, 12141.817872731739, 12542.498300067895, 11281.605143819927, 11414.029807466459, 11422.200445969034, 11663.416829158678, 11855.940720296343, 11280.2667826591, 11330.94334528322, 11459.0, 11609.129315301556, 11862.22895511789, 11203.495842687262, 11426.557388442428, 11646.825297620373, 11731.41342932867, 12076.637700868989, 9141.725748227564, 9391.859122113037, 9558.665446709332, 9783.608655653694, 10183.083522483012, 7779.487897019828, 9336.31215669793, 9410.717678469657, 9419.858702119336, 9437.150656440679], "value": 7130.9584518109405, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1496.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 113.0, 113.0, 114.0, 114.0, 114.0, 113.0, 112.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 112.0, 115.0, 151.0, 113.0, 111.0, 110.0, 104.0, 135.0, 114.0], "value": 121.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 198.0, 185.0, 186.0, 189.0, 185.0, 185.0, 183.0, 187.0, 186.0], "value": 187.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 51.0, 60.0, 107.0, 88.0, 84.0, 60.0, 62.0, 91.0, 82.0], "value": 76.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 72.0, 89.0, 68.0, 70.0, 70.0, 86.0, 68.0, 68.0, 85.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 90.0, 90.0, 90.0, 93.0, 133.0, 109.0, 89.0, 90.0], "value": 96.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 97.0, 96.0, 97.0, 96.0, 103.0, 96.0, 95.0], "value": 96.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 88.0, 88.0, 88.0, 86.0, 88.0, 87.0, 100.0, 139.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 58.0, 61.0, 61.0, 61.0, 60.0, 60.0, 60.0, 61.0], "value": 60.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 70.0, 65.0, 75.0, 74.0, 69.0, 69.0, 69.0, 68.0, 74.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 93.0, 93.0, 92.0, 100.0, 113.0, 109.0], "value": 97.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 145.0, 148.0, 143.0, 134.0, 144.0, 147.0, 180.0, 161.0], "value": 150.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 184.0, 182.0, 184.0, 182.0, 186.0, 188.0, 183.0, 182.0], "value": 183.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 68.0, 70.0, 68.0, 69.0, 73.0, 74.0, 84.0, 82.0], "value": 72.7, "unit": "score"}]}]} 06:17:17 INFO - Return code: 0 06:17:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:17:17 ERROR - # TBPL SUCCESS # 06:17:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:17:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:17:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:17:17 INFO - 2017-02-14 06:17:17.731 screenresolution[2196:25443] starting screenresolution argv=screenresolution get 06:17:17 INFO - 2017-02-14 06:17:17.734 screenresolution[2196:25443] Display 0: 1600x1200x32@60 06:17:17 INFO - 2017-02-14 06:17:17.740 screenresolution[2197:25446] starting screenresolution argv=screenresolution list 06:17:17 INFO - Available Modes on Display 0 06:17:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:17:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:17:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:17:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:17:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:17:17 INFO - Intel Iris: 06:17:17 INFO - Chipset Model: Intel Iris 06:17:17 INFO - Type: GPU 06:17:17 INFO - Bus: Built-In 06:17:17 INFO - VRAM (Dynamic, Max): 1536 MB 06:17:17 INFO - Vendor: Intel (0x8086) 06:17:17 INFO - Device ID: 0x0a2e 06:17:17 INFO - Revision ID: 0x0009 06:17:17 INFO - Displays: 06:17:17 INFO - Display: 06:17:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:17:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:17:17 INFO - Display Serial Number: 1600x1200 60 06:17:17 INFO - Main Display: Yes 06:17:17 INFO - Mirror: Off 06:17:17 INFO - Online: Yes 06:17:17 INFO - Rotation: Supported 06:17:17 INFO - Return code: 0 06:17:17 INFO - Running post-action listener: _resource_record_post_action 06:17:17 INFO - [mozharness: 2017-02-14 14:17:17.983670Z] Finished run-tests step (success) 06:17:17 INFO - Running post-run listener: _resource_record_post_run 06:17:18 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 339968; Write bytes: 552819200; Read time: 4; Write time: 1662 06:17:18 INFO - TinderboxPrint: CPU usage
53.9% 06:17:18 INFO - TinderboxPrint: I/O read bytes / time
339,968 / 4 06:17:18 INFO - TinderboxPrint: I/O write bytes / time
552,819,200 / 1,662 06:17:18 INFO - TinderboxPrint: CPU idle
2,219.9 (46.1%) 06:17:18 INFO - TinderboxPrint: CPU system
963.2 (20.0%) 06:17:18 INFO - TinderboxPrint: CPU user
1,634.5 (33.9%) 06:17:18 INFO - TinderboxPrint: Swap in / out
252,604,416 / 0 06:17:18 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 240421376; Write bytes: 232968192; Read time: 17588; Write time: 504 06:17:18 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 323584; Write bytes: 298379776; Read time: 4; Write time: 1105 06:17:18 INFO - Running post-run listener: _upload_blobber_files 06:17:18 INFO - Blob upload gear active. 06:17:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:17:18 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 06:17:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:17:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:17:18 INFO - (blobuploader) - INFO - Open directory for files ... 06:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:19 INFO - (blobuploader) - INFO - Done attempting. 06:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:21 INFO - (blobuploader) - INFO - Done attempting. 06:17:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 06:17:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:22 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 06:17:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:22 INFO - (blobuploader) - INFO - Done attempting. 06:17:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:17:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:17:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:17:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:17:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:17:24 INFO - (blobuploader) - INFO - Done attempting. 06:17:24 INFO - (blobuploader) - INFO - Iteration through files over. 06:17:24 INFO - Return code: 0 06:17:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:17:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:17:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42a1a830f94d677615c75adb7faa7d8e6345b55d40c30de4655b97f0448c7c5a522eee515785e85d2a27840548f371dac9c63777bcd71a7a2a4acc5ddc8966bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3283367ebc8e3b62ce12e95b8e0dfccf1848e609f7726ae52253bd526ac1fdb8e3ea9cc504bb2f1d1557c5e435ab793b3c79a41af9ac47ed40b7cec34b3fe97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cea74c6f245252be62a73b8995f5144297037aafb0c35c3551aac00de85c5ee4fa20ac7521ef235440494f60f744353f9f6adedd27d09e07a93c0087c29f7ffa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dcfafad9e27a9d6d97da5047d9dc2274916eae572d4c0ab66758ab2af73662ced155029d2293bc43f3cbde0d80824570431d3a208b90548042eae8e9a4cc7a4"} 06:17:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:17:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:17:24 INFO - Contents: 06:17:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42a1a830f94d677615c75adb7faa7d8e6345b55d40c30de4655b97f0448c7c5a522eee515785e85d2a27840548f371dac9c63777bcd71a7a2a4acc5ddc8966bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3283367ebc8e3b62ce12e95b8e0dfccf1848e609f7726ae52253bd526ac1fdb8e3ea9cc504bb2f1d1557c5e435ab793b3c79a41af9ac47ed40b7cec34b3fe97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cea74c6f245252be62a73b8995f5144297037aafb0c35c3551aac00de85c5ee4fa20ac7521ef235440494f60f744353f9f6adedd27d09e07a93c0087c29f7ffa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dcfafad9e27a9d6d97da5047d9dc2274916eae572d4c0ab66758ab2af73662ced155029d2293bc43f3cbde0d80824570431d3a208b90548042eae8e9a4cc7a4"} 06:17:24 INFO - Running post-run listener: copy_logs_to_upload_dir 06:17:24 INFO - Copying logs to upload dir... 06:17:24 INFO - mkdir: /builds/slave/test/build/upload/logs 06:17:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.277221 ========= master_lag: 1.14 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-02-14 06:17:25.866487) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 06:17:25.870419) ========= 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.Kg1j13nsM7/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.sHe34nzhqp/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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/42a1a830f94d677615c75adb7faa7d8e6345b55d40c30de4655b97f0448c7c5a522eee515785e85d2a27840548f371dac9c63777bcd71a7a2a4acc5ddc8966bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3283367ebc8e3b62ce12e95b8e0dfccf1848e609f7726ae52253bd526ac1fdb8e3ea9cc504bb2f1d1557c5e435ab793b3c79a41af9ac47ed40b7cec34b3fe97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cea74c6f245252be62a73b8995f5144297037aafb0c35c3551aac00de85c5ee4fa20ac7521ef235440494f60f744353f9f6adedd27d09e07a93c0087c29f7ffa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dcfafad9e27a9d6d97da5047d9dc2274916eae572d4c0ab66758ab2af73662ced155029d2293bc43f3cbde0d80824570431d3a208b90548042eae8e9a4cc7a4"} build_url:https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011509 build_url: 'https://queue.taskcluster.net/v1/task/Wph0ElC8TRedB5jTXfOpIw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/42a1a830f94d677615c75adb7faa7d8e6345b55d40c30de4655b97f0448c7c5a522eee515785e85d2a27840548f371dac9c63777bcd71a7a2a4acc5ddc8966bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3283367ebc8e3b62ce12e95b8e0dfccf1848e609f7726ae52253bd526ac1fdb8e3ea9cc504bb2f1d1557c5e435ab793b3c79a41af9ac47ed40b7cec34b3fe97", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cea74c6f245252be62a73b8995f5144297037aafb0c35c3551aac00de85c5ee4fa20ac7521ef235440494f60f744353f9f6adedd27d09e07a93c0087c29f7ffa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5dcfafad9e27a9d6d97da5047d9dc2274916eae572d4c0ab66758ab2af73662ced155029d2293bc43f3cbde0d80824570431d3a208b90548042eae8e9a4cc7a4"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-14 06:17:25.919561) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 06:17:25.919966) ========= 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.Kg1j13nsM7/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.sHe34nzhqp/Listeners TMPDIR=/var/folders/ny/jtz5t9tn5hsgvkr_fh45rj8r00000w/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: 1.78 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2017-02-14 06:17:27.708239) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 06:17:27.708561) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-14 06:17:27.712935) ========= ========= Total master_lag: 3.05 =========