builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0094 starttime: 1488041402.67 results: success (0) buildid: 20170225072309 builduid: c470a3b890234a44986baa32f202cdc1 revision: a957c33cd9c618341d1bdc9bce9e57481bff4e34 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:02.665668) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:02.666229) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:02.666521) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:02.695583) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:02.695992) ========= 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.HXOn0otHSp/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.NE33DWpuRA/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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-25 08:50:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 21.5M=0.001s 2017-02-25 08:50:02 (21.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151563 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:02.871868) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:02.872170) ========= 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.HXOn0otHSp/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.NE33DWpuRA/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.028650 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:02.925204) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-25 08:50:02.925718) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a957c33cd9c618341d1bdc9bce9e57481bff4e34 --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 a957c33cd9c618341d1bdc9bce9e57481bff4e34 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HXOn0otHSp/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.NE33DWpuRA/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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-25 08:50:03,030 truncating revision to first 12 chars 2017-02-25 08:50:03,030 Setting DEBUG logging. 2017-02-25 08:50:03,031 attempt 1/10 2017-02-25 08:50:03,031 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a957c33cd9c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-25 08:50:04,680 unpacking tar archive at: mozilla-central-a957c33cd9c6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.914308 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-25 08:50:04.864716) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:04.865017) ========= script_repo_revision: a957c33cd9c618341d1bdc9bce9e57481bff4e34 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:04.865405) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:04.865668) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-25 08:50:04.885737) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-25 08:50:04.886086) ========= /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.HXOn0otHSp/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.NE33DWpuRA/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:50:05 INFO - MultiFileLogger online at 20170225 08:50:05 in /builds/slave/test 08:50:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:50:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:50:05 INFO - {'append_to_log': False, 08:50:05 INFO - 'base_work_dir': '/builds/slave/test', 08:50:05 INFO - 'blob_upload_branch': 'Firefox', 08:50:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:50:05 INFO - 'branch': 'Firefox', 08:50:05 INFO - 'buildbot_json_path': 'buildprops.json', 08:50:05 INFO - 'config_files': ('talos/mac_config.py',), 08:50:05 INFO - 'default_actions': ('clobber', 08:50:05 INFO - 'read-buildbot-config', 08:50:05 INFO - 'download-and-extract', 08:50:05 INFO - 'populate-webroot', 08:50:05 INFO - 'create-virtualenv', 08:50:05 INFO - 'install', 08:50:05 INFO - 'run-tests'), 08:50:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:50:05 INFO - 'download_minidump_stackwalk': True, 08:50:05 INFO - 'download_symbols': 'ondemand', 08:50:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:50:05 INFO - 'tooltool.py': '/tools/tooltool.py', 08:50:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:50:05 INFO - '/tools/misc-python/virtualenv.py')}, 08:50:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:50:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:50:05 INFO - 'gecko_profile': False, 08:50:05 INFO - 'gecko_profile_interval': 0, 08:50:05 INFO - 'installer_path': 'installer.exe', 08:50:05 INFO - 'log_level': 'info', 08:50:05 INFO - 'log_name': 'talos', 08:50:05 INFO - 'log_to_console': True, 08:50:05 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:50:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:50:05 INFO - 'opt_config_files': (), 08:50:05 INFO - 'pip_index': False, 08:50:05 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:05 INFO - 'cmd': ('bash', 08:50:05 INFO - '-c', 08:50:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:05 INFO - 'enabled': True, 08:50:05 INFO - 'halt_on_failure': False, 08:50:05 INFO - 'name': 'check_screen_resolution'},), 08:50:05 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:50:05 INFO - 'cmd': ('bash', 08:50:05 INFO - '-c', 08:50:05 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:50:05 INFO - 'enabled': True, 08:50:05 INFO - 'halt_on_failure': False, 08:50:05 INFO - 'name': 'check_screen_resolution'},), 08:50:05 INFO - 'run_cmd_checks_enabled': True, 08:50:05 INFO - 'suite': 'dromaeojs', 08:50:05 INFO - 'system_bits': '32', 08:50:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:50:05 INFO - 'title': 't-yosemite-r7-0094', 08:50:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:50:05 INFO - 'use_talos_json': True, 08:50:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:50:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:50:05 INFO - 'work_dir': 'build'} 08:50:05 INFO - [mozharness: 2017-02-25 16:50:05.104093Z] Running clobber step. 08:50:05 INFO - Running pre-action listener: _resource_record_pre_action 08:50:05 INFO - Running main action method: clobber 08:50:05 INFO - rmtree: /builds/slave/test/build 08:50:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:50:07 INFO - Running post-action listener: _resource_record_post_action 08:50:07 INFO - [mozharness: 2017-02-25 16:50:07.763532Z] Finished clobber step (success) 08:50:07 INFO - [mozharness: 2017-02-25 16:50:07.763661Z] Running read-buildbot-config step. 08:50:07 INFO - Running pre-action listener: _resource_record_pre_action 08:50:07 INFO - Running main action method: read_buildbot_config 08:50:07 INFO - Using buildbot properties: 08:50:07 INFO - { 08:50:07 INFO - "project": "", 08:50:07 INFO - "product": "firefox", 08:50:07 INFO - "script_repo_revision": "production", 08:50:07 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:50:07 INFO - "repository": "", 08:50:07 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:50:07 INFO - "buildid": "20170225072309", 08:50:07 INFO - "pgo_build": "False", 08:50:07 INFO - "basedir": "/builds/slave/test", 08:50:07 INFO - "buildnumber": 7, 08:50:07 INFO - "slavename": "t-yosemite-r7-0094", 08:50:07 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:50:07 INFO - "platform": "yosemite_r7", 08:50:07 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:50:07 INFO - "branch": "mozilla-central", 08:50:07 INFO - "repo_path": "mozilla-central", 08:50:07 INFO - "revision": "a957c33cd9c618341d1bdc9bce9e57481bff4e34", 08:50:07 INFO - "stage_platform": "macosx64", 08:50:07 INFO - "builduid": "c470a3b890234a44986baa32f202cdc1", 08:50:07 INFO - "slavebuilddir": "test" 08:50:07 INFO - } 08:50:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 08:50:07 INFO - Running post-action listener: _resource_record_post_action 08:50:07 INFO - [mozharness: 2017-02-25 16:50:07.766935Z] Finished read-buildbot-config step (success) 08:50:07 INFO - [mozharness: 2017-02-25 16:50:07.767042Z] Running download-and-extract step. 08:50:07 INFO - Running pre-action listener: _resource_record_pre_action 08:50:07 INFO - Running main action method: download_and_extract 08:50:07 INFO - mkdir: /builds/slave/test/build/tests 08:50: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')]} 08:50:07 INFO - trying https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 08:50:07 INFO - Downloading https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/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 08:50:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/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 08:50:08 INFO - Downloaded 1199 bytes. 08:50:08 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:50:08 INFO - Using the following test package requirements: 08:50:08 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:50:08 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:50:08 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 08:50:08 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:50:08 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 08:50:08 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:50:08 INFO - u'jsshell-mac.zip'], 08:50:08 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:50:08 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 08:50:08 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:50:08 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:50:08 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 08:50:08 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:50:08 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 08:50:08 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:50:08 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 08:50:08 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:50:08 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 08:50:08 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:50:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:50:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:50:08 INFO - Fetch https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:50:10 INFO - Expected file size: 51743715 08:50:10 INFO - Obtained file size: 51743715 08:50:26 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 08:50:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:50:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:50:26 INFO - Fetch https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:50:27 INFO - Expected file size: 51743715 08:50:27 INFO - Obtained file size: 51743715 08:50:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 08:50:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:50:42 INFO - Fetch https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 08:50:43 INFO - Expected file size: 14404421 08:50:43 INFO - Obtained file size: 14404421 08:50: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')]} 08:50:44 INFO - trying https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:50:44 INFO - Downloading https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 08:50:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/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 08:50:46 INFO - Downloaded 74929284 bytes. 08:50:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:50:46 INFO - mkdir: /builds/slave/test/properties 08:50:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:50:46 INFO - Writing to file /builds/slave/test/properties/build_url 08:50:46 INFO - Contents: 08:50:46 INFO - build_url:https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:50:46 INFO - Running post-action listener: _resource_record_post_action 08:50:46 INFO - Running post-action listener: set_extra_try_arguments 08:50:46 INFO - [mozharness: 2017-02-25 16:50:46.966164Z] Finished download-and-extract step (success) 08:50:46 INFO - [mozharness: 2017-02-25 16:50:46.966316Z] Running populate-webroot step. 08:50:46 INFO - Running pre-action listener: _resource_record_pre_action 08:50:46 INFO - Running main action method: populate_webroot 08:50:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:50:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:50:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:50:46 INFO - '--tppagecycles', 08:50:46 INFO - '7'], 08:50:46 INFO - 'tests': ['tsvgm']}}, 08:50:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:50:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:50:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:50:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:50:46 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:50:46 INFO - 'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:46 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:50:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:50:46 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:50:46 INFO - 'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['damp', 'tps']}, 08:50:46 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:50:46 INFO - 'tests': ['damp', 'tps']}, 08:50:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['dromaeo_dom']}, 08:50:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:50:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['basic_compositor_video']}, 08:50:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:50:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['a11yr', 08:50:46 INFO - 'ts_paint', 08:50:46 INFO - 'tpaint', 08:50:46 INFO - 'sessionrestore', 08:50:46 INFO - 'sessionrestore_no_auto_restore', 08:50:46 INFO - 'tabpaint']}, 08:50:46 INFO - 'other-e10s': {'tests': ['a11yr', 08:50:46 INFO - 'ts_paint', 08:50:46 INFO - 'tpaint', 08:50:46 INFO - 'sessionrestore', 08:50:46 INFO - 'sessionrestore_no_auto_restore', 08:50:46 INFO - 'tabpaint']}, 08:50:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:50:46 INFO - 'ts_paint', 08:50:46 INFO - 'tpaint', 08:50:46 INFO - 'sessionrestore', 08:50:46 INFO - 'sessionrestore_no_auto_restore', 08:50:46 INFO - 'tabpaint']}, 08:50:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:50:46 INFO - 'ts_paint', 08:50:46 INFO - 'tpaint', 08:50:46 INFO - 'sessionrestore', 08:50:46 INFO - 'sessionrestore_no_auto_restore', 08:50:46 INFO - 'tabpaint']}, 08:50:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['a11yr', 08:50:46 INFO - 'ts_paint', 08:50:46 INFO - 'tpaint', 08:50:46 INFO - 'sessionrestore', 08:50:46 INFO - 'sessionrestore_no_auto_restore', 08:50:46 INFO - 'tabpaint']}, 08:50:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['a11yr', 08:50:46 INFO - 'ts_paint', 08:50:46 INFO - 'tpaint', 08:50:46 INFO - 'sessionrestore', 08:50:46 INFO - 'sessionrestore_no_auto_restore', 08:50:46 INFO - 'tabpaint']}, 08:50:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['tsvgx', 08:50:46 INFO - 'tsvgr_opacity', 08:50:46 INFO - 'tart', 08:50:46 INFO - 'tscrollx', 08:50:46 INFO - 'cart', 08:50:46 INFO - 'tsvg_static']}, 08:50:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:50:46 INFO - 'tsvgr_opacity', 08:50:46 INFO - 'tart', 08:50:46 INFO - 'tscrollx', 08:50:46 INFO - 'cart', 08:50:46 INFO - 'tsvg_static']}, 08:50:46 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:50:46 INFO - 'talos_options': ['--disable-e10s'], 08:50:46 INFO - 'tests': ['tp5o']}, 08:50:46 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:50:46 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:50:46 INFO - 'talos_options': ['--disable-e10s', 08:50:46 INFO - '--xperf_path', 08:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:46 INFO - 'tests': ['tp5n']}, 08:50:46 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:50:46 INFO - 'talos_options': ['--xperf_path', 08:50:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:50:46 INFO - 'tests': ['tp5n']}}, 08:50:46 INFO - 'talos.zip': {'path': '', 08:50:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:50:46 INFO - Running post-action listener: _resource_record_post_action 08:50:46 INFO - [mozharness: 2017-02-25 16:50:46.985066Z] Finished populate-webroot step (success) 08:50:46 INFO - [mozharness: 2017-02-25 16:50:46.985195Z] Running create-virtualenv step. 08:50:46 INFO - Running pre-action listener: _resource_record_pre_action 08:50:46 INFO - Running main action method: create_virtualenv 08:50:46 INFO - Creating virtualenv /builds/slave/test/build/venv 08:50:46 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 08:50:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:50:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:50:47 INFO - Using real prefix '/tools/python27' 08:50:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:50:47 INFO - Installing distribute.............................................................................................................................................................................................done. 08:50:50 INFO - Installing pip.................done. 08:50:50 INFO - Return code: 0 08:50:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:50:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:50:50 INFO - Reading from file tmpfile_stdout 08:50:50 INFO - Output received: 08:50:50 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) 08:50:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:50 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 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:50:50 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 08:50:50 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 08:50:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:50:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:50 INFO - 'HOME': '/Users/cltbld', 08:50:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:50 INFO - 'LOGNAME': 'cltbld', 08:50:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:50 INFO - 'MOZ_NO_REMOTE': '1', 08:50:50 INFO - 'NO_EM_RESTART': '1', 08:50:50 INFO - 'PAGER': '/bin/cat', 08:50:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:50 INFO - 'PWD': '/builds/slave/test', 08:50:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:50 INFO - 'SHELL': '/bin/bash', 08:50:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:50:50 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:50:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:50 INFO - 'USER': 'cltbld', 08:50:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:50 INFO - 'XPC_FLAGS': '0x0', 08:50:50 INFO - 'XPC_SERVICE_NAME': '0', 08:50:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:50:51 INFO - Cleaning up... 08:50:51 INFO - Return code: 0 08:50:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:50:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:50:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:50:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:50:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:51 INFO - 'HOME': '/Users/cltbld', 08:50:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:51 INFO - 'LOGNAME': 'cltbld', 08:50:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:51 INFO - 'MOZ_NO_REMOTE': '1', 08:50:51 INFO - 'NO_EM_RESTART': '1', 08:50:51 INFO - 'PAGER': '/bin/cat', 08:50:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:51 INFO - 'PWD': '/builds/slave/test', 08:50:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:51 INFO - 'SHELL': '/bin/bash', 08:50:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:50:51 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:50:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:51 INFO - 'USER': 'cltbld', 08:50:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:51 INFO - 'XPC_FLAGS': '0x0', 08:50:51 INFO - 'XPC_SERVICE_NAME': '0', 08:50:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:51 INFO - Downloading/unpacking psutil>=3.1.1 08:50:51 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 08:50:51 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 08:50:51 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 08:50:51 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 08:50:51 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 08:50:51 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 08:50:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:50:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:55 INFO - Installing collected packages: psutil 08:50:55 INFO - Running setup.py install for psutil 08:50:55 INFO - building 'psutil._psutil_osx' extension 08:50:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 08:50:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 08:50:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 08:50:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 08:50:56 INFO - building 'psutil._psutil_posix' extension 08:50:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 08:50:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:50:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:50:56 INFO - ^ 08:50:56 INFO - 1 warning generated. 08:50:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 08:50:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:50:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:50:56 INFO - Successfully installed psutil 08:50:56 INFO - Cleaning up... 08:50:56 INFO - Return code: 0 08:50:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:50:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:50:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:50:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:50:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:50:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:56 INFO - 'HOME': '/Users/cltbld', 08:50:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:56 INFO - 'LOGNAME': 'cltbld', 08:50:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:56 INFO - 'MOZ_NO_REMOTE': '1', 08:50:56 INFO - 'NO_EM_RESTART': '1', 08:50:56 INFO - 'PAGER': '/bin/cat', 08:50:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:56 INFO - 'PWD': '/builds/slave/test', 08:50:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:56 INFO - 'SHELL': '/bin/bash', 08:50:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:50:56 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:50:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:56 INFO - 'USER': 'cltbld', 08:50:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:56 INFO - 'XPC_FLAGS': '0x0', 08:50:56 INFO - 'XPC_SERVICE_NAME': '0', 08:50:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:50:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:50:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50: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 08:50:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:50:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:50:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:50:59 INFO - Installing collected packages: mozsystemmonitor 08:50:59 INFO - Running setup.py install for mozsystemmonitor 08:50:59 INFO - Successfully installed mozsystemmonitor 08:50:59 INFO - Cleaning up... 08:50:59 INFO - Return code: 0 08:50:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:50:59 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')]} 08:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:59 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')]} 08:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:50:59 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 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:50:59 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 08:50:59 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 08:50:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:50:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:50:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:50:59 INFO - 'HOME': '/Users/cltbld', 08:50:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:50:59 INFO - 'LOGNAME': 'cltbld', 08:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:50:59 INFO - 'MOZ_NO_REMOTE': '1', 08:50:59 INFO - 'NO_EM_RESTART': '1', 08:50:59 INFO - 'PAGER': '/bin/cat', 08:50:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:50:59 INFO - 'PWD': '/builds/slave/test', 08:50:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:50:59 INFO - 'SHELL': '/bin/bash', 08:50:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:50:59 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:50:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:50:59 INFO - 'USER': 'cltbld', 08:50:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:50:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:50:59 INFO - 'XPC_FLAGS': '0x0', 08:50:59 INFO - 'XPC_SERVICE_NAME': '0', 08:50:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:00 INFO - Downloading/unpacking jsonschema==2.5.1 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51: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 08:51:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:51:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:51:02 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 08:51:02 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 08:51:02 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 08:51:02 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 08:51:02 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 08:51:02 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 08:51:03 INFO - Downloading functools32-3.2.3-2.tar.gz 08:51:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:51:03 INFO - warning: no files found matching '*.txt' 08:51:03 INFO - no previously-included directories found matching 'build' 08:51:03 INFO - no previously-included directories found matching 'dist' 08:51:03 INFO - no previously-included directories found matching '.git*' 08:51:03 INFO - Installing collected packages: jsonschema, functools32 08:51:03 INFO - Running setup.py install for functools32 08:51:03 INFO - warning: no files found matching '*.txt' 08:51:03 INFO - no previously-included directories found matching 'build' 08:51:03 INFO - no previously-included directories found matching 'dist' 08:51:03 INFO - no previously-included directories found matching '.git*' 08:51:03 INFO - Successfully installed jsonschema functools32 08:51:03 INFO - Cleaning up... 08:51:03 INFO - Return code: 0 08:51:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:03 INFO - 'HOME': '/Users/cltbld', 08:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:03 INFO - 'LOGNAME': 'cltbld', 08:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:03 INFO - 'MOZ_NO_REMOTE': '1', 08:51:03 INFO - 'NO_EM_RESTART': '1', 08:51:03 INFO - 'PAGER': '/bin/cat', 08:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:03 INFO - 'PWD': '/builds/slave/test', 08:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:03 INFO - 'SHELL': '/bin/bash', 08:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:51:03 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:03 INFO - 'USER': 'cltbld', 08:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:03 INFO - 'XPC_FLAGS': '0x0', 08:51:03 INFO - 'XPC_SERVICE_NAME': '0', 08:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:03 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:51:03 INFO - Cleaning up... 08:51:03 INFO - Return code: 0 08:51:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:51:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:51:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:51:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:51:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:03 INFO - 'HOME': '/Users/cltbld', 08:51:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:03 INFO - 'LOGNAME': 'cltbld', 08:51:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:03 INFO - 'MOZ_NO_REMOTE': '1', 08:51:03 INFO - 'NO_EM_RESTART': '1', 08:51:03 INFO - 'PAGER': '/bin/cat', 08:51:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:03 INFO - 'PWD': '/builds/slave/test', 08:51:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:03 INFO - 'SHELL': '/bin/bash', 08:51:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:51:03 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:51:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:03 INFO - 'USER': 'cltbld', 08:51:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:03 INFO - 'XPC_FLAGS': '0x0', 08:51:03 INFO - 'XPC_SERVICE_NAME': '0', 08:51:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:04 INFO - Downloading/unpacking blobuploader==1.2.4 08:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:06 INFO - Downloading blobuploader-1.2.4.tar.gz 08:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:51:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:51:06 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 08:51:06 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 08:51:06 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 08:51:06 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 08:51:06 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 08:51:06 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 08:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:51:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:51:07 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 08:51:07 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 08:51:07 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 08:51:07 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 08:51:07 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 08:51:07 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 08:51:07 INFO - Downloading docopt-0.6.1.tar.gz 08:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:51:07 INFO - Installing collected packages: blobuploader, requests, docopt 08:51:07 INFO - Running setup.py install for blobuploader 08:51:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:51:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:51:08 INFO - Running setup.py install for requests 08:51:08 INFO - Running setup.py install for docopt 08:51:08 INFO - Successfully installed blobuploader requests docopt 08:51:08 INFO - Cleaning up... 08:51:08 INFO - Return code: 0 08:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:08 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')]} 08:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:08 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')]} 08:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:08 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 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:51:08 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 08:51:08 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 08:51:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:51:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:08 INFO - 'HOME': '/Users/cltbld', 08:51:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:08 INFO - 'LOGNAME': 'cltbld', 08:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:08 INFO - 'MOZ_NO_REMOTE': '1', 08:51:08 INFO - 'NO_EM_RESTART': '1', 08:51:08 INFO - 'PAGER': '/bin/cat', 08:51:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:08 INFO - 'PWD': '/builds/slave/test', 08:51:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:08 INFO - 'SHELL': '/bin/bash', 08:51:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:51:08 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:51:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:08 INFO - 'USER': 'cltbld', 08:51:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:08 INFO - 'XPC_FLAGS': '0x0', 08:51:08 INFO - 'XPC_SERVICE_NAME': '0', 08:51:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:09 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-jxVA84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:09 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-44cZPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:09 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-5Chvjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:09 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-qTwLGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:09 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-7bN_4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:09 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-E0xSZq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:09 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-CHIKu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:09 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-1VA86B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:09 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-mM9nRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-n5Bgkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-VJz4x8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-pb6VEm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ix5v04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-AwHngy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-yWxjzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-hxUekt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:10 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-N4Ynwf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:51:10 INFO - Running setup.py install for manifestparser 08:51:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:51:11 INFO - Running setup.py install for mozcrash 08:51:11 INFO - Running setup.py install for mozdebug 08:51:11 INFO - Running setup.py install for mozdevice 08:51:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:51:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:51:11 INFO - Running setup.py install for mozfile 08:51:11 INFO - Running setup.py install for mozhttpd 08:51:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:51:11 INFO - Running setup.py install for mozinfo 08:51:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:51:11 INFO - Running setup.py install for mozInstall 08:51:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Running setup.py install for mozleak 08:51:12 INFO - Running setup.py install for mozlog 08:51:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Running setup.py install for moznetwork 08:51:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Running setup.py install for mozprocess 08:51:12 INFO - Running setup.py install for mozprofile 08:51:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Running setup.py install for mozrunner 08:51:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:51:12 INFO - Running setup.py install for mozscreenshot 08:51:13 INFO - Running setup.py install for moztest 08:51:13 INFO - Running setup.py install for mozversion 08:51:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:51:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:51:13 INFO - Cleaning up... 08:51:13 INFO - Return code: 0 08:51:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:13 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')]} 08:51:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:13 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')]} 08:51:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:13 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 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:51:13 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 08:51:13 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 08:51:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:51:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:13 INFO - 'HOME': '/Users/cltbld', 08:51:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:13 INFO - 'LOGNAME': 'cltbld', 08:51:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:13 INFO - 'MOZ_NO_REMOTE': '1', 08:51:13 INFO - 'NO_EM_RESTART': '1', 08:51:13 INFO - 'PAGER': '/bin/cat', 08:51:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:13 INFO - 'PWD': '/builds/slave/test', 08:51:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:13 INFO - 'SHELL': '/bin/bash', 08:51:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:51:13 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:51:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:13 INFO - 'USER': 'cltbld', 08:51:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:13 INFO - 'XPC_FLAGS': '0x0', 08:51:13 INFO - 'XPC_SERVICE_NAME': '0', 08:51:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:51:13 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-6EBDTk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:51:13 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)) 08:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:51:13 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-PDVQKR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:51:13 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)) 08:51:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:51:13 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-3IIYM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:51:14 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)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-1BDQxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:51:14 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)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-zyEqNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:51:14 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)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-joI2HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:51:14 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)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-3t6GbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:51:14 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)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-vdeqw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:51:14 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)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-aAlisA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:51:14 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)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-b3Z7SU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:51:14 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)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-5XRSkK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:51:14 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)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-WETw3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:51:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:51:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:51:14 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-31G7yT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:51:15 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)) 08:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:51:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-ZWHmnT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:51:15 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)) 08:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-sJ3RjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:51:15 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)) 08:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:51:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-m8Kxbv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:51:15 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)) 08:51:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:51:15 INFO - Running setup.py (path:/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/pip-VMBbI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:51:15 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)) 08:51:15 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)) 08:51:15 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)) 08:51:15 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)) 08:51:15 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)) 08:51:15 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)) 08:51:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:18 INFO - Downloading blessings-1.6.tar.gz 08:51:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:51:18 INFO - Installing collected packages: blessings 08:51:18 INFO - Running setup.py install for blessings 08:51:18 INFO - Successfully installed blessings 08:51:18 INFO - Cleaning up... 08:51:18 INFO - Return code: 0 08:51:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:51:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:18 INFO - Reading from file tmpfile_stdout 08:51:18 INFO - Current package versions: 08:51:18 INFO - blessings == 1.6 08:51:18 INFO - blobuploader == 1.2.4 08:51:18 INFO - docopt == 0.6.1 08:51:18 INFO - functools32 == 3.2.3-2 08:51:18 INFO - jsonschema == 2.5.1 08:51:18 INFO - manifestparser == 1.1 08:51:18 INFO - mozInstall == 1.12 08:51:18 INFO - mozcrash == 1.0 08:51:18 INFO - mozdebug == 0.1 08:51:18 INFO - mozdevice == 0.49 08:51:18 INFO - mozfile == 1.2 08:51:18 INFO - mozhttpd == 0.7 08:51:18 INFO - mozinfo == 0.9 08:51:18 INFO - mozleak == 0.1 08:51:18 INFO - mozlog == 3.4 08:51:18 INFO - moznetwork == 0.27 08:51:18 INFO - mozprocess == 0.25 08:51:18 INFO - mozprofile == 0.28 08:51:18 INFO - mozrunner == 6.13 08:51:18 INFO - mozscreenshot == 0.1 08:51:18 INFO - mozsystemmonitor == 0.3 08:51:18 INFO - moztest == 0.8 08:51:18 INFO - mozversion == 1.4 08:51:18 INFO - psutil == 3.1.1 08:51:18 INFO - requests == 1.2.3 08:51:18 INFO - wsgiref == 0.1.2 08:51:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:51:18 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')]} 08:51:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:18 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')]} 08:51:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:18 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 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:51:18 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 08:51:18 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 08:51:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:51:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:18 INFO - 'HOME': '/Users/cltbld', 08:51:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:18 INFO - 'LOGNAME': 'cltbld', 08:51:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:18 INFO - 'MOZ_NO_REMOTE': '1', 08:51:18 INFO - 'NO_EM_RESTART': '1', 08:51:18 INFO - 'PAGER': '/bin/cat', 08:51:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:18 INFO - 'PWD': '/builds/slave/test', 08:51:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:18 INFO - 'SHELL': '/bin/bash', 08:51:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:51:18 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:51:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:18 INFO - 'USER': 'cltbld', 08:51:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:18 INFO - 'XPC_FLAGS': '0x0', 08:51:18 INFO - 'XPC_SERVICE_NAME': '0', 08:51:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:19 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)) 08:51:19 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)) 08:51:19 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)) 08:51:19 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)) 08:51:19 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)) 08:51:19 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)) 08:51:19 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)) 08:51:19 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)) 08:51:19 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)) 08:51:19 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)) 08:51:19 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)) 08:51:19 INFO - Cleaning up... 08:51:19 INFO - Return code: 0 08:51:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:51:19 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')]} 08:51:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:19 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')]} 08:51:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:19 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 0x10cf69b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cf6c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa87bcb9440>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, '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.HXOn0otHSp/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.NE33DWpuRA/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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 08:51:19 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 08:51:19 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 08:51:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:51:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:19 INFO - 'HOME': '/Users/cltbld', 08:51:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:19 INFO - 'LOGNAME': 'cltbld', 08:51:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:19 INFO - 'MOZ_NO_REMOTE': '1', 08:51:19 INFO - 'NO_EM_RESTART': '1', 08:51:19 INFO - 'PAGER': '/bin/cat', 08:51:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:19 INFO - 'PWD': '/builds/slave/test', 08:51:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:19 INFO - 'SHELL': '/bin/bash', 08:51:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:51:19 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:51:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:19 INFO - 'USER': 'cltbld', 08:51:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:19 INFO - 'XPC_FLAGS': '0x0', 08:51:19 INFO - 'XPC_SERVICE_NAME': '0', 08:51:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:51:19 INFO - Cleaning up... 08:51:19 INFO - Return code: 0 08:51:19 INFO - Running post-action listener: _resource_record_post_action 08:51:19 INFO - Running post-action listener: _start_resource_monitoring 08:51:19 INFO - Starting resource monitoring. 08:51:19 INFO - [mozharness: 2017-02-25 16:51:19.366677Z] Finished create-virtualenv step (success) 08:51:19 INFO - [mozharness: 2017-02-25 16:51:19.367657Z] Running install step. 08:51:19 INFO - Running pre-action listener: _resource_record_pre_action 08:51:19 INFO - Running main action method: install 08:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:51:19 INFO - Reading from file tmpfile_stdout 08:51:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:51:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:51:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:51:19 INFO - Reading from file tmpfile_stdout 08:51:19 INFO - Output received: 08:51:19 INFO - Usage: mozinstall [options] installer 08:51:19 INFO - Options: 08:51:19 INFO - -h, --help show this help message and exit 08:51:19 INFO - -d DEST, --destination=DEST 08:51:19 INFO - Directory to install application into. [default: 08:51:19 INFO - "/builds/slave/test"] 08:51:19 INFO - --app=APP Application being installed. [default: firefox] 08:51:19 INFO - mkdir: /builds/slave/test/build/application 08:51:19 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'] 08:51:19 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 08:51:40 INFO - Reading from file tmpfile_stdout 08:51:40 INFO - Output received: 08:51:40 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:51:40 INFO - Running post-action listener: _resource_record_post_action 08:51:40 INFO - [mozharness: 2017-02-25 16:51:40.059572Z] Finished install step (success) 08:51:40 INFO - [mozharness: 2017-02-25 16:51:40.059708Z] Running run-tests step. 08:51:40 INFO - Running pre-action listener: _resource_record_pre_action 08:51:40 INFO - Running main action method: run_tests 08:51:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:51:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:51:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:51:40 INFO - 2017-02-25 08:51:40.074 screenresolution[1630:10156] starting screenresolution argv=screenresolution get 08:51:40 INFO - 2017-02-25 08:51:40.077 screenresolution[1630:10156] Display 0: 1600x1200x32@60 08:51:40 INFO - 2017-02-25 08:51:40.083 screenresolution[1631:10159] starting screenresolution argv=screenresolution list 08:51:40 INFO - Available Modes on Display 0 08:51:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:51:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:51:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:51:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:51:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:51:40 INFO - Intel Iris: 08:51:40 INFO - Chipset Model: Intel Iris 08:51:40 INFO - Type: GPU 08:51:40 INFO - Bus: Built-In 08:51:40 INFO - VRAM (Dynamic, Max): 1536 MB 08:51:40 INFO - Vendor: Intel (0x8086) 08:51:40 INFO - Device ID: 0x0a2e 08:51:40 INFO - Revision ID: 0x0009 08:51:40 INFO - Displays: 08:51:40 INFO - Display: 08:51:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:51:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:51:40 INFO - Display Serial Number: 1600x1200 60 08:51:40 INFO - Main Display: Yes 08:51:40 INFO - Mirror: Off 08:51:40 INFO - Online: Yes 08:51:40 INFO - Rotation: Supported 08:51:40 INFO - Return code: 0 08:51:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:51:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:51:40 INFO - Python 2.7.3 08:51:40 INFO - Return code: 0 08:51:40 INFO - grabbing minidump binary from tooltool 08:51:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:40 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 0x10cd47d30>, '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 0x10cc6edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cd3cbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:51:40 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 08:51:40 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 08:51:40 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 08:51:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:51:40 INFO - Return code: 0 08:51:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:51:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:51:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:51:40 INFO - ENV: RUST_BACKTRACE is now 1 08:51:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:51:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:51:40 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/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 08:51:40 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/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0094 --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 08:51:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HXOn0otHSp/Render', 08:51:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:51:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:51:40 INFO - 'HOME': '/Users/cltbld', 08:51:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:51:40 INFO - 'LOGNAME': 'cltbld', 08:51:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:51:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:51:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:40 INFO - 'MOZ_NO_REMOTE': '1', 08:51:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:51:40 INFO - 'NO_EM_RESTART': '1', 08:51:40 INFO - 'PAGER': '/bin/cat', 08:51:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:51:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:40 INFO - 'PWD': '/builds/slave/test', 08:51:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:51:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:51:40 INFO - 'RUST_BACKTRACE': '1', 08:51:40 INFO - 'SHELL': '/bin/bash', 08:51:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NE33DWpuRA/Listeners', 08:51:40 INFO - 'TMPDIR': '/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/', 08:51:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:51:40 INFO - 'USER': 'cltbld', 08:51:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:51:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:51:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:40 INFO - 'XPC_FLAGS': '0x0', 08:51:40 INFO - 'XPC_SERVICE_NAME': '0', 08:51:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:51:40 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/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0094', '--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 08:51:40 INFO - mozversion application_buildid: 20170225072309 08:51:40 INFO - mozversion application_changeset: a957c33cd9c618341d1bdc9bce9e57481bff4e34 08:51:40 INFO - mozversion application_display_name: Nightly 08:51:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:51:40 INFO - mozversion application_name: Firefox 08:51:40 INFO - mozversion application_remotingname: firefox 08:51:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:51:40 INFO - mozversion application_vendor: Mozilla 08:51:40 INFO - mozversion application_version: 54.0a1 08:51:40 INFO - mozversion platform_buildid: 20170225072309 08:51:40 INFO - mozversion platform_changeset: a957c33cd9c618341d1bdc9bce9e57481bff4e34 08:51:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:51:40 INFO - mozversion platform_version: 54.0a1 08:51:40 INFO - using testdate: 1488041500 08:51:40 INFO - actual date: 1488041500 08:51:40 INFO - starting webserver on 'localhost:49240' 08:51:40 INFO - SUITE-START | Running 2 tests 08:51:40 INFO - TEST-START | dromaeo_css 08:51:40 INFO - operating with platform_type : mac_ 08:51:40 INFO - Initialising browser for dromaeo_css test... 08:51:40 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpvbLQiX/profile http://localhost:49240/getInfo.html) 08:51:43 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 08:51:43 INFO - PROCESS | 1641 | colorDepth:24 08:51:43 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 08:51:43 INFO - PROCESS | 1641 | __metrics 08:51:43 INFO - PROCESS | 1641 | 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" 08:51:43 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:51:44 INFO - TEST-INFO | 1641: exit 0 08:51:44 INFO - Browser initialized. 08:51:44 INFO - Running cycle 1/1 for dromaeo_css test... 08:51:44 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmpvbLQiX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:51:56 INFO - PROCESS | 1643 | RSS: Main: 231882752 08:51:56 INFO - PROCESS | 1643 | 08:54:59 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 08:55:03 INFO - PROCESS | 1643 | RSS: Main: 539394048 08:55:03 INFO - PROCESS | 1643 | 08:56:46 INFO - PROCESS | 1643 | ************************* 08:56:46 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 08:56:46 INFO - PROCESS | 1643 | 08:56:46 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:56:46 INFO - PROCESS | 1643 | Full stack: 08:56:46 INFO - PROCESS | 1643 | ************************* 08:58:06 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 08:58:07 INFO - PROCESS | 1643 | RSS: Main: 364699648 08:58:07 INFO - PROCESS | 1643 | 09:01:09 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 09:01:10 INFO - PROCESS | 1643 | RSS: Main: 345632768 09:01:10 INFO - PROCESS | 1643 | 09:04:12 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 09:04:13 INFO - PROCESS | 1643 | RSS: Main: 350064640 09:04:13 INFO - PROCESS | 1643 | 09:07:17 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 09:07:17 INFO - PROCESS | 1643 | RSS: Main: 341307392 09:07:17 INFO - PROCESS | 1643 | 09:10:21 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 09:10:21 INFO - PROCESS | 1643 | RSS: Main: 443105280 09:10:21 INFO - PROCESS | 1643 | 09:10:21 INFO - PROCESS | 1643 | __start_tp_report 09:10:21 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 09:10:21 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 09:10:21 INFO - PROCESS | 1643 | |i|pagename|runs| 09:10:21 INFO - PROCESS | 1643 | |0;dojo.html;3283.671632836716;3295.719863811574;3296.604407471104;3335.5330253764478;3336.582927134108;5410.594205434589;5495.6153069285165;5516.889662206753;5616.887662246752;5625.887482250352;5505.834824955257;5567.025770490169;5598.964191624552;5617.38208797032;5649.378568357477;4204.306289462235;5065.316182315396;5106.897862042757;5113.079645663779;5172.32759741235;5243.659162154448;5245.213218017289;5255.632105752599;5260.368755749316;5278.815241466549;4997.775100120467;5022.799088036474;5038.244263360525;5177.068127737025;5249.632525723201;5083.415407228179;5088.338515992898;5122.231665250242;5130.435652078306;5193.2989046479;5042.445331013586;5072.822451214227;5082.517160869711;5108.591312694975;5126.102931986888;5418.566514678816;5573.972130139364;5581.413951535112;5587.7485513152005;5596.608237423382;6052.12244224585;6097.969510152465;6106.664133472657;6110.633361998294;6116.724747386378;5015.724135172564;5167.48325167484;6119.593952096689;6127.403330890726;6172;5683.948469533149;5688.431156884279;5695.800646977336;5703.600747947646;5704.344000440003;6144.310314663503;6217;6217.440430361289;6238;6252.280987686383;6024.427679370453;6031.4270144336215;6031.7587296507645;6036.909446358308;6040.365761595057;6122.825106970096;6132.581522417052;6144.5084393248435;6152.384761523901;6195.473384762256;5173.482651734872;6171.691415429211;6191.597546159485;6198.597091189058;6201.131841542187;6190.81427557174;6195.19462469876;6209.348018458088;6211.503079753609;6220.813375598739;4811.08589368019;4875.463698993108;4877.146499362669;4904.975475122602;4964.404271487445;4353.325234588644;4356.259435895905;4363.890902727394;4453.398791163217;4464.196444639931;5406.351237851404;5506.2841830562575;5527.834164975057;5563.054280772279;5569.916451253234;6021.337652858182;6055.394460553909;6177.227846519185;6179.536534759911;6246.375362463808;5677.091665333527;5686.829395118153;5691.459311365414;5692.9146062809095;5721.685307308055;5213.165893457029;5357.973210133924;5369.140937450067;5387.057264978613;5393.056215162331;6171.13604095427;6221.09794079865;6234.064890266496;6241.968790156111;6242.750289988349;6080.935836228731;6090.634561926121;6100.847478813065;6114.991026480581;6116.847078823065;5009.250731500603;6178.382161783786;6209.5032397409;6232.688365581612;6247.5939063960695;6127.617148554337;6137.355577664281;6139.022574051671;6144.525313924537;6149.169862068564;6196.845078873064;6204.5036397089025;6213;6213.409726076015;6215.06773983906;5776.249087618583;5840.737166827418;6018.157457955977;6024.427679370453;6067.120267561268;5884.6469211845715;5899.380565040609;5900.055991041413;5900.380460051804;5902.38025007368;5268.947310526845;5571.415001424954;5662.915056274242;5751.568632352507;5757.625754325955;5849.53203743708;5900.262467191601;5901.468867801918;5916.55625828056;5916.792912248051;5717.142428635738;5753.626014309224;5824.097264923944;5843.532517398683;5875.588708790344 09:10:21 INFO - PROCESS | 1643 | |1;ext.html;456.89034631688406;457.6384656121664;477.4032459425718;478.514307977403;483.5116532302378;39414.817555473346;41303;41500.79249603755;41532.377014344806;41705;41851.581484185226;42299.36550951738;42349.576504234945;42377.576224237746;42411.575884241145;7590.5066170699;9514.666986655451;9761.219102471821;9761.609535618602;9772.218222542215;7634.809129771745;7768.922310776905;7778.4166187535875;7779.727709530168;11387.430628468584;9980.201583873273;11599.768004639902;11858.407079646026;11866.466009029571;11876.524939002473;11682.240654357482;11768.352740599265;11769.2938423694;11772.587959421378;11779.823302650424;7499.137599176055;11375.601853935155;11591.362475063868;11592.826107608393;11596.76806463866;28056.719432805614;39065;39920.60079399198;40352;41907.37138942918;3756.7558108722847;3789.5263092113487;3806.2042523527307;3828.119532507511;3845.134844659929;20544.897275513675;27308.45383092347;29576.81692732288;29756.256093597618;30275.545866812015;3121.438141134595;3171.762117841148;3190.6490286068515;3237.611486621597;3248.0742988248235;443963;445980;446070;446374;446577;49270.50729492731;51307;51321.486785131674;62485;63133.5806493541;68477.31522684709;68966.65516672484;70013;70028;70436.94344584836;15229.923850380677;15487;15521.84478155204;15525.068495890057;15560.610984725472;11773.411329433666;12001.87998120025;12002;12005.2196607222;12012.099092568093;18023;18027.008514531564;18046.368377107;18061.458156255332;18075.00587467702;5438.226504482743;6533.085368048477;6560.507961902877;6587.5626018373505;6605.471562275006;819.7499762572472;857.2156476823636;861.2248975921596;870.3680598877105;891.8840550728364;26480.867595661897;28931.85534072358;28958;29734.553981690293;29757.702422975493;896.5248418338291;920.7329874336367;1030.1861529391847;1078.7141407527013;1208.8428504294561;12438.315892625993;13508.257045862572;14590.927045364706;14743.926280368529;15007.474738384322;790148;808338;809084;809857;810399;51332.74333628308;51802.48197517976;51821.48178518242;51828.96342073137;51846.48153518492;1355.2817006986313;1378.7725025370903;1403.5508637235987;1406.951820893441;1407.4088882669098;23376;25514.23457296284;27317.487690885166;28095.157145285673;28108.578371324857;44246.557534424246;44562.66312010645;44617.55382446134;44622.3306650394;44894;429761;431997;434143;434997;436140;20403.693944590545;21065.894670526548;21660.45848853791;21670.783292166878;24127.276181714577;40331.79834100811;40827.7958610205;40922.79538602288;41251.1749765009;41407.585924140374;32800.83599581987;33603.32793344168;33954.66045339515;35135.47296790499;35442.29115417626;33825;33842.66157338395;35014.29971400608;35320.646793531734;35379.11552211215;33470.66529334773;33887.661123388454;34563.48154777731;34593.48109778305;34772.304553909285;28809.70356333928;30161.849190753906;30783.846080769454;30806.691933080383;30828.53757193599;23228.65157022612;23381.649275260545;23423.656986164777;23632.29103126909;23890.88054559716 09:10:21 INFO - PROCESS | 1643 | |2;jquery.html;354.53732878593456;377.2812791631942;385.8225216400456;389.66683485619797;409.01631576059566;14260.215688137148;14648.70702585949;20161.39515814526;20983.790162098376;21298.89350553245;20650.586988260227;21471;21529.892350538266;21593.892030539864;21734.239301624446;5348.786048558053;5627.352854421732;5649;5652.236948012028;5652.236948012028;5475.945240547583;5618.297712785902;6182.536309776762;6231.252249730039;6232.626042437446;6197.411245931629;6199.016314779273;6207.099970504274;6208.627482351051;6215.316315205324;5504.091824848895;5514.696691681956;5575.498205161555;5580.107182850765;5601;4724.126036683225;5447.019536483432;5453.563714902798;5459.12653975366;5470.17947307903;12364.62906112818;12693.492260309577;20638.071286792132;25506.744932550624;27005.729942700713;2589.184406911817;2598.428345763929;2662.60060990851;2682.6244325794405;2881.5965764792945;15622.843771562253;16770.22043228076;16823.495295141165;17309.826901731074;18090.366837160767;1921.8270355667917;1951.388545121523;1957.559549101455;1969.5371587676884;1988.801119888014;149162.99999999892;150504;159068;161948;163073;16648.417305394254;22578.661320080213;22601.434964126027;22677.124418250154;22933;39667.809965701075;40478;40641.12306523177;40691;40760.4783234681;10935.890641093647;11039.613613523488;11067;11124.666260012213;11277.94361028206;8693.348793506742;8739.825203495895;8850.822983540293;8939.955300223457;9181.219596334253;10489.737756556147;10644.254902156774;10694;10794.892051079389;10799.514021869034;3561.3467966365224;4139.937900931488;4203.97898010508;4278.700490965664;4283.443152390231;736.5249414127965;852.2713080316364;857.7255278311005;860.264473874828;873.3321437776208;15985.760213596805;19520.31678891232;22669.2065777697;22712.205072822704;22775.886120569292;862.1680078724062;885.1723638398119;905.0949050949051;906.6418764587951;911.5715613661569;10428.791424171473;11390.031847292907;11687.76624467523;11691.941540292244;11710.414479276002;516981;703630;709167;719425;727785;121136;133179.66820331867;133524;143063.56936430503;158784.20607896885;438.61840199026415;458.9632829373642;459.37983721975735;461.53385081068365;461.5430723583628;11046.226764126433;11336.94331528337;11518.884811151782;11537.653870383901;11905.226160299553;57494;59027.524311890826;59424.21727348187;59673.40326596679;60462.69768651129;84970.57514712386;86427.56786216029;87089.56455217683;87910;88979;6962.582245065312;8253.546054967035;8517.659293628185;8529.360297977553;8842.381033327863;12609.810852837398;13132.606021819362;13304.600861974157;13501.122427042212;13764.793528097287;5710.200571919851;6745.662716864235;11027;11042.779144417227;11344.773104537699;10317.123044541298;10643.94678026605;11042.447877605928;11495.907888750555;11578.594749183738;11257.549698011988;11336.6032188873;11613.6515904523;11658.00906922887;11735.061195104541;7118.323759242864;8322.37582181351;8505.106963768716;8594.484330940164;8608.865235846108;8771.912280877365;10872.293300935415;11394.772104558027;11408.657740267805;11503.539858405904 09:10:21 INFO - PROCESS | 1643 | |3;mootools.html;1430.9427622895084;1443.0129234686015;1449.304333919719;1450.9782353264702;1459.3287087939548;7997.160298168688;8390.958045209773;8393.454425462342;8394.58027098645;8407.621657025433;8135.023797144336;8236.17638236176;8366.665333386673;8382.455140415885;8469.44948578342;2237.1498830444407;2281.8060464860505;2281.954360912789;2286.0969916882823;2286.748457669655;2243.798058174764;2274.3631783100677;2277.954440911181;2280.703508543887;2282.1556024271044;2241.618924782783;2244.618414869476;2269.6822444857735;2274.033535747309;2278.054607337953;2184.868907865533;2201.515666553356;2226.1206823304865;2227.40973641985;2229.141780414536;2201.9119235230573;2232.0625337358347;2242.5066485373354;2244.640857462798;2244.921427750021;8326;8370.330373570161;8403.453775504633;8406.28546573542;8407.327413806943;5001.874953126165;5152.92270615941;5163.380394352665;5165.974170129125;5170.25031370453;2561.948761024788;3061.663217046123;3197.4404479216046;3241.97877668536;3243.5459035735016;900.459724165502;922.2437601167046;1061.4268295120626;1110.6890070780114;1134.155054484406;9667.951660241724;9978.201743860474;9996.400215987136;10776.946115269373;10872.45637718111;3918.804059796999;4244.533101358848;4392.780360982002;4396.3625274335045;4410.33844923264;8697.91302086971;8716;8730.257928076184;8730.337247139556;8758.080401557872;4323.7621930793475;4479.148961697332;4826.806927722922;4960.503949605083;5053.2420136979745;4583.816647334136;4686.976565117153;4736.076465089274;4743.620510359232;4755.500672429414;3537.25717599307;3601.513795637555;3618.16782140104;3670.9082272942856;3674.2284120334493;1130.9773804523863;1131.1007748839693;1134.6028889888473;1147.942602869853;1149.080735411684;757.9052618422697;822.6056833666996;857.6697971281102;869.6390997735868;872.8739925496039;5127.846444380064;5215.374155101412;5240;5563.972180139073;5582.553395728332;573.9913901291484;578.6788332475517;584.1967294969417;592.2123575644382;594.7918228619949;3394.62659107498;3479.634638362986;3587.766795158306;3591.586967498719;3597.5503062117236;9586.520673966414;9819.214462842956;9910.653127140515;9931.056549627774;9947.403155810674;9861.901380986243;9884;9889.20886329092;9900.752481187883;9901.306908516479;6493.967530162319;7521.962390188014;7708.884366734504;7804.453688241769;7818.179091195342;5193.195054766517;5248.265242866079;5324.121519949165;5382.111951528111;5394.622376433769;8929.73210803677;9183.31125165602;9203.907960920305;9215.49314787693;9228.215601673664;7656.272654097852;7829;7857.489263197874;8754.080821513904;9294.535273236446;7036.542624729376;7222.3860971817985;7224.638768061681;7225.277472252733;7237.746678866214;7711.498752581064;7827.726029588937;7867.331276841533;7887.369010479033;7914.24814642608;7058.929410705828;7070.222275549582;7093.1488221413765;7141.250168732416;7245;5657.830265092054;6926.341997510229;6959.860802784017;7049.330313620198;7053.6825842838225;6332.208473940757;6448.258450278278;6451.612903225821;6451.870962580629;6456.709448074942;4616.469106052847;4730.219513780187;4791.305260737104;4844.079624871404;4891.682040667345;4659.114768194032;4718.127146477913;4827.517248275144;4938.358013458371;4965.602751779921 09:10:21 INFO - PROCESS | 1643 | |4;prototype.html;337.9442392005318;353.90995733141915;362.90564453242155;363.4911124425805;365.70377993825;5076.695398276106;5148.665336753108;5148.794048238066;5152.505773325731;5185.688858668483;4140.565240649726;4973.204287314031;5070.822521211759;5139.331886854713;5150.536451719354;2796.566532187514;3883.8834834954855;4083.8979025524304;4087.3664581989838;4099.631033207011;3096.845157742115;3481.267205243884;3929.607039296076;3935.311320518912;3941.3840325466563;3731.813409329536;3877.111551893843;3894.9805250973704;3921.0393453603906;3939.8227079781477;3900.980495097535;3915.921681566367;3917.3928041153667;3952.841886324544;3965.8413663453425;2692.892284308625;3119.4385010698065;3410.4202285611505;3436.553248077759;3453.2920751246183;4918.360613120271;4942.975285123552;4954.5540901319055;4954.628402869763;4954.950450495521;4448.132614140244;4453.332000199964;4472.351509031172;4473.2842745160615;4474.865754027352;4235.830566777326;4925.532074452921;4983.501649834988;5146.536811686966;5508.862278443031;3671.7980511071883;3713.962860371416;3757.647246991081;3760.9435858462143;3767.9811600942094;4498.910021799546;5282.705737094398;5584.956198871625;5678.772849086032;5828.679422631753;3197.840107994591;3356.6139893912023;3555;3769.7946701180117;3772.8113594320175;3181.9522707159413;3667;3831.8467261309793;3833.1950290438763;3847.788371639587;3602.8018458984484;4085.080856807195;4174.7893110997475;4309.534758182233;4485.820567177277;4580.931286030645;4806.351142595775;5374.838754837361;5435.592330575223;5481.5340696041285;1060.1624716474053;1141.9143564232716;1223.2049168040667;1230.2188110549687;1244.8381710377773;771.6141929035482;790.5256845892419;838.6058552480324;839.5811079276004;860.8923884514436;4244.8089835956835;4504.941338785383;4765.499622539653;4816.242071643825;4817.13291607507;4473.530279320689;4967.428745694219;5000.74996250186;5377.924415116992;5414.160805075219;4109.445224894661;4160.908340707331;4344.435223420998;4837.4920633332995;4877.731789734695;2491.327341617753;2552.659853576887;2652.9307140430496;2721.986390068037;2798.874050667725;4575.839845605387;5121.206213036985;5126.5898728101665;5409;5477.233187353773;4788.880277993008;5123.87190320245;5220.455420331029;5428.67427954324;5492.862678433071;4429.800658970354;4462.898285691478;4763.69036012665;5145.9742701287005;5523.25436066142;4427.339747594652;4649.814007439664;5251.894962100813;5293.761780719954;5332.22682710997;4285.5928686774705;4885.95114048855;4992.675476094042;5143.948560514347;5314.5482633975;4743.83396581118;4872.588068905914;5124.410692770379;5330.733463326896;5460.399356070909;2955.482790511695;3249.5288183213775;3579.4451859961746;3603.153258984189;3613.674769270778;4621.79201935907;5312;5482.917756233739;5530.253415788817;5532.474414930736;3862.3820188769664;5326.946730532645;5327.547158491571;5369.979703856255;5468.671879687232;5313.867153321044;5322.600804939722;5363.800841654903;5371.194320851903;5385.9192112119135;4478.820847166207;4518.299663552155;5059.898802024012;5264.842054738364;5412.323459567554;4775.6657034007285;5145.948540514547;5329.626926115135;5410;5443.319585051869;4463.928657122202;4847.830325938575;5003.799848006184;5049.924251136309;5163.948360516347 09:10:21 INFO - PROCESS | 1643 | |5;yui.html;696.9930300696994;699.6326928362606;744.3226663736;752.0290877301039;797.0833541427357;14508.782368264472;15166.165860877647;15196.012259203144;15210.16344101074;15222.391104355826;11446.828297575543;13665.590032299022;13884.722305553883;14190.43238270468;14367.137971721704;901.4591245252861;908.2098574240387;908.9727308180732;909.5997760985179;909.7725568607848;894.8702438146497;908.2007833106857;909.6315992023241;914.9817003659923;924.6809850601531;968.0658164870898;969.60730903984;970.1656575345197;972.6984634763211;973.1873885305778;965.2278177458005;967.3953778888194;967.9612815487337;968.3512046928504;969.0406497567428;715.9606221657859;718.0485856240502;718.195620904585;718.5257729898242;719.1765428584295;13834;15231.619209519851;15260.847391526053;15279.159646219454;15320.693586128327;13628.35557944402;13835.515756948458;13861.514846980308;13945.16329020262;14179.858201417957;11314.886851131549;11465.426728663533;11486.368249746261;11646.650600481998;12194.81707774384;3522;3529.2764983178645;3533.896867296726;3592.0660628236847;3631.346357655621;79947;92937.535312323;95511.0448895509;95730;96565.55151672731;10397.425966751962;10567.577296908037;10662.73343166427;10812.837807432894;10856;21666.783332166793;21985.67021494679;22004.559908802054;22053;22106.668399974013;7333.853322933512;7405.037345145097;7409.666565004588;7569.47013709035;7575.128860181039;3938.8621398250925;4022.577629348876;4063.5733248009124;4075.2053349596545;4169.291220492523;3555.253396786704;3650.470681751131;3652.7625704329134;3665.2852693724467;3667.889963301052;638.2404938123618;641.3938827807677;645.8514541655352;667.9332066793281;670.2928410526941;505.5062290930292;617.9032217813417;618.2920555963397;620.3951147631113;668.1781408867121;9345;9904.105781448534;9953.203743700487;10096.34373765703;10775.622853200257;540.9080456322434;580.1001719369016;580.4137820801021;623.8533944523033;670.0920253057135;4393.231184542692;4813.374261346003;4874.775719561253;4940.382452193476;4945.406551213878;69210.65394672994;84333.57833210917;88525;89668.5516572413;92175.53912230396;52296.47703522916;52754.73622631939;56014.43985560174;74554.25445745581;74930;35752.82123589365;66335.39130652117;68078.65960670264;68171;69110.999999999;10092.84860727075;10457.68626941193;10472.476376181008;10587.523561439599;10599.947000265258;40681.38977915393;44329.33505997477;44560.88597785081;44671;45435.545644543134;59067.40932590791;59493.70253148706;60510.09234861393;61500.76998460095;62409;11823.586174483851;11829.76340473203;12104.515819367127;12168.391580421121;12357.505699771908;14228.502002429865;14291.857081429052;14318.916784541338;14387.856121438652;14988.850111498745;13322.200667959953;13421.463141474233;13635.931820340835;13736.244506552235;13807.86192138106;13204.669883252996;13238.338083096;13360.665983350495;13478.19130852152;14005.43978240859;12799.488020479077;13376.264305463294;13821.516246931309;13909.443622254996;13923.791143133063;9941.65204217849;10123.088921997056;10446.164306855282;10585.523651435858;11698.824517632413;5895.911561326498;8771;9985.350952188375;10837.349759014485;10932.234743567873 09:10:21 INFO - PROCESS | 1643 | __end_tp_report 09:10:21 INFO - PROCESS | 1643 | __start_cc_report 09:10:21 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,3624 09:10:21 INFO - PROCESS | 1643 | __end_cc_report 09:10:21 INFO - PROCESS | 1643 | __startTimestamp1488042621549__endTimestamp 09:10:21 INFO - PROCESS | 1643 | 09:10:21 INFO - PROCESS | 1643 | ------- Summary: start ------- 09:10:21 INFO - PROCESS | 1643 | Number of tests: 6 09:10:21 INFO - PROCESS | 1643 | 09:10:21 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5616.52 Median:5721.69 stddev:634.45 (11.1%) stddev-sans-first:609.43 09:10:21 INFO - PROCESS | 1643 | Values: 3283.7 3295.7 3296.6 3335.5 3336.6 5410.6 5495.6 5516.9 5616.9 5625.9 5505.8 5567.0 5599.0 5617.4 5649.4 4204.3 5065.3 5106.9 5113.1 5172.3 5243.7 5245.2 5255.6 5260.4 5278.8 4997.8 5022.8 5038.2 5177.1 5249.6 5083.4 5088.3 5122.2 5130.4 5193.3 5042.4 5072.8 5082.5 5108.6 5126.1 5418.6 5574.0 5581.4 5587.7 5596.6 6052.1 6098.0 6106.7 6110.6 6116.7 5015.7 5167.5 6119.6 6127.4 6172.0 5683.9 5688.4 5695.8 5703.6 5704.3 6144.3 6217.0 6217.4 6238.0 6252.3 6024.4 6031.4 6031.8 6036.9 6040.4 6122.8 6132.6 6144.5 6152.4 6195.5 5173.5 6171.7 6191.6 6198.6 6201.1 6190.8 6195.2 6209.3 6211.5 6220.8 4811.1 4875.5 4877.1 4905.0 4964.4 4353.3 4356.3 4363.9 4453.4 4464.2 5406.4 5506.3 5527.8 5563.1 5569.9 6021.3 6055.4 6177.2 6179.5 6246.4 5677.1 5686.8 5691.5 5692.9 5721.7 5213.2 5358.0 5369.1 5387.1 5393.1 6171.1 6221.1 6234.1 6242.0 6242.8 6080.9 6090.6 6100.8 6115.0 6116.8 5009.3 6178.4 6209.5 6232.7 6247.6 6127.6 6137.4 6139.0 6144.5 6149.2 6196.8 6204.5 6213.0 6213.4 6215.1 5776.2 5840.7 6018.2 6024.4 6067.1 5884.6 5899.4 5900.1 5900.4 5902.4 5268.9 5571.4 5662.9 5751.6 5757.6 5849.5 5900.3 5901.5 5916.6 5916.8 5717.1 5753.6 5824.1 5843.5 5875.6 09:10:21 INFO - PROCESS | 1643 | 09:10:21 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:68279.50 Median:35349.88 stddev:158227.97 (447.6%) stddev-sans-first:158589.89 09:10:21 INFO - PROCESS | 1643 | Values: 456.9 457.6 477.4 478.5 483.5 39414.8 41303.0 41500.8 41532.4 41705.0 41851.6 42299.4 42349.6 42377.6 42411.6 7590.5 9514.7 9761.2 9761.6 9772.2 7634.8 7768.9 7778.4 7779.7 11387.4 9980.2 11599.8 11858.4 11866.5 11876.5 11682.2 11768.4 11769.3 11772.6 11779.8 7499.1 11375.6 11591.4 11592.8 11596.8 28056.7 39065.0 39920.6 40352.0 41907.4 3756.8 3789.5 3806.2 3828.1 3845.1 20544.9 27308.5 29576.8 29756.3 30275.5 3121.4 3171.8 3190.6 3237.6 3248.1 443963.0 445980.0 446070.0 446374.0 446577.0 49270.5 51307.0 51321.5 62485.0 63133.6 68477.3 68966.7 70013.0 70028.0 70436.9 15229.9 15487.0 15521.8 15525.1 15560.6 11773.4 12001.9 12002.0 12005.2 12012.1 18023.0 18027.0 18046.4 18061.5 18075.0 5438.2 6533.1 6560.5 6587.6 6605.5 819.7 857.2 861.2 870.4 891.9 26480.9 28931.9 28958.0 29734.6 29757.7 896.5 920.7 1030.2 1078.7 1208.8 12438.3 13508.3 14590.9 14743.9 15007.5 790148.0 808338.0 809084.0 809857.0 810399.0 51332.7 51802.5 51821.5 51829.0 51846.5 1355.3 1378.8 1403.6 1407.0 1407.4 23376.0 25514.2 27317.5 28095.2 28108.6 44246.6 44562.7 44617.6 44622.3 44894.0 429761.0 431997.0 434143.0 434997.0 436140.0 20403.7 21065.9 21660.5 21670.8 24127.3 40331.8 40827.8 40922.8 41251.2 41407.6 32800.8 33603.3 33954.7 35135.5 35442.3 33825.0 33842.7 35014.3 35320.6 35379.1 33470.7 33887.7 34563.5 34593.5 34772.3 28809.7 30161.8 30783.8 30806.7 30828.5 23228.7 23381.6 23423.7 23632.3 23890.9 09:10:21 INFO - PROCESS | 1643 | 09:10:21 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:40025.16 Median:14943.66 stddev:114006.72 (762.9%) stddev-sans-first:114287.63 09:10:21 INFO - PROCESS | 1643 | Values: 354.5 377.3 385.8 389.7 409.0 14260.2 14648.7 20161.4 20983.8 21298.9 20650.6 21471.0 21529.9 21593.9 21734.2 5348.8 5627.4 5649.0 5652.2 5652.2 5475.9 5618.3 6182.5 6231.3 6232.6 6197.4 6199.0 6207.1 6208.6 6215.3 5504.1 5514.7 5575.5 5580.1 5601.0 4724.1 5447.0 5453.6 5459.1 5470.2 12364.6 12693.5 20638.1 25506.7 27005.7 2589.2 2598.4 2662.6 2682.6 2881.6 15622.8 16770.2 16823.5 17309.8 18090.4 1921.8 1951.4 1957.6 1969.5 1988.8 149163.0 150504.0 159068.0 161948.0 163073.0 16648.4 22578.7 22601.4 22677.1 22933.0 39667.8 40478.0 40641.1 40691.0 40760.5 10935.9 11039.6 11067.0 11124.7 11277.9 8693.3 8739.8 8850.8 8940.0 9181.2 10489.7 10644.3 10694.0 10794.9 10799.5 3561.3 4139.9 4204.0 4278.7 4283.4 736.5 852.3 857.7 860.3 873.3 15985.8 19520.3 22669.2 22712.2 22775.9 862.2 885.2 905.1 906.6 911.6 10428.8 11390.0 11687.8 11691.9 11710.4 516981.0 703630.0 709167.0 719425.0 727785.0 121136.0 133179.7 133524.0 143063.6 158784.2 438.6 459.0 459.4 461.5 461.5 11046.2 11336.9 11518.9 11537.7 11905.2 57494.0 59027.5 59424.2 59673.4 60462.7 84970.6 86427.6 87089.6 87910.0 88979.0 6962.6 8253.5 8517.7 8529.4 8842.4 12609.8 13132.6 13304.6 13501.1 13764.8 5710.2 6745.7 11027.0 11042.8 11344.8 10317.1 10643.9 11042.4 11495.9 11578.6 11257.5 11336.6 11613.7 11658.0 11735.1 7118.3 8322.4 8505.1 8594.5 8608.9 8771.9 10872.3 11394.8 11408.7 11503.5 09:10:21 INFO - PROCESS | 1643 | 09:10:21 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5264.51 Median:5353.12 stddev:2916.79 (54.5%) stddev-sans-first:2910.74 09:10:21 INFO - PROCESS | 1643 | Values: 1430.9 1443.0 1449.3 1451.0 1459.3 7997.2 8391.0 8393.5 8394.6 8407.6 8135.0 8236.2 8366.7 8382.5 8469.4 2237.1 2281.8 2282.0 2286.1 2286.7 2243.8 2274.4 2278.0 2280.7 2282.2 2241.6 2244.6 2269.7 2274.0 2278.1 2184.9 2201.5 2226.1 2227.4 2229.1 2201.9 2232.1 2242.5 2244.6 2244.9 8326.0 8370.3 8403.5 8406.3 8407.3 5001.9 5152.9 5163.4 5166.0 5170.3 2561.9 3061.7 3197.4 3242.0 3243.5 900.5 922.2 1061.4 1110.7 1134.2 9668.0 9978.2 9996.4 10776.9 10872.5 3918.8 4244.5 4392.8 4396.4 4410.3 8697.9 8716.0 8730.3 8730.3 8758.1 4323.8 4479.1 4826.8 4960.5 5053.2 4583.8 4687.0 4736.1 4743.6 4755.5 3537.3 3601.5 3618.2 3670.9 3674.2 1131.0 1131.1 1134.6 1147.9 1149.1 757.9 822.6 857.7 869.6 872.9 5127.8 5215.4 5240.0 5564.0 5582.6 574.0 578.7 584.2 592.2 594.8 3394.6 3479.6 3587.8 3591.6 3597.6 9586.5 9819.2 9910.7 9931.1 9947.4 9861.9 9884.0 9889.2 9900.8 9901.3 6494.0 7522.0 7708.9 7804.5 7818.2 5193.2 5248.3 5324.1 5382.1 5394.6 8929.7 9183.3 9203.9 9215.5 9228.2 7656.3 7829.0 7857.5 8754.1 9294.5 7036.5 7222.4 7224.6 7225.3 7237.7 7711.5 7827.7 7867.3 7887.4 7914.2 7058.9 7070.2 7093.1 7141.3 7245.0 5657.8 6926.3 6959.9 7049.3 7053.7 6332.2 6448.3 6451.6 6451.9 6456.7 4616.5 4730.2 4791.3 4844.1 4891.7 4659.1 4718.1 4827.5 4938.4 4965.6 09:10:21 INFO - PROCESS | 1643 | 09:10:21 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4223.75 Median:4696.82 stddev:1289.49 (27.5%) stddev-sans-first:1259.69 09:10:21 INFO - PROCESS | 1643 | Values: 337.9 353.9 362.9 363.5 365.7 5076.7 5148.7 5148.8 5152.5 5185.7 4140.6 4973.2 5070.8 5139.3 5150.5 2796.6 3883.9 4083.9 4087.4 4099.6 3096.8 3481.3 3929.6 3935.3 3941.4 3731.8 3877.1 3895.0 3921.0 3939.8 3901.0 3915.9 3917.4 3952.8 3965.8 2692.9 3119.4 3410.4 3436.6 3453.3 4918.4 4943.0 4954.6 4954.6 4955.0 4448.1 4453.3 4472.4 4473.3 4474.9 4235.8 4925.5 4983.5 5146.5 5508.9 3671.8 3714.0 3757.6 3760.9 3768.0 4498.9 5282.7 5585.0 5678.8 5828.7 3197.8 3356.6 3555.0 3769.8 3772.8 3182.0 3667.0 3831.8 3833.2 3847.8 3602.8 4085.1 4174.8 4309.5 4485.8 4580.9 4806.4 5374.8 5435.6 5481.5 1060.2 1141.9 1223.2 1230.2 1244.8 771.6 790.5 838.6 839.6 860.9 4244.8 4504.9 4765.5 4816.2 4817.1 4473.5 4967.4 5000.7 5377.9 5414.2 4109.4 4160.9 4344.4 4837.5 4877.7 2491.3 2552.7 2652.9 2722.0 2798.9 4575.8 5121.2 5126.6 5409.0 5477.2 4788.9 5123.9 5220.5 5428.7 5492.9 4429.8 4462.9 4763.7 5146.0 5523.3 4427.3 4649.8 5251.9 5293.8 5332.2 4285.6 4886.0 4992.7 5143.9 5314.5 4743.8 4872.6 5124.4 5330.7 5460.4 2955.5 3249.5 3579.4 3603.2 3613.7 4621.8 5312.0 5482.9 5530.3 5532.5 3862.4 5326.9 5327.5 5370.0 5468.7 5313.9 5322.6 5363.8 5371.2 5385.9 4478.8 4518.3 5059.9 5264.8 5412.3 4775.7 5145.9 5329.6 5410.0 5443.3 4463.9 4847.8 5003.8 5049.9 5163.9 09:10:21 INFO - PROCESS | 1643 | 09:10:21 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:17909.13 Median:24361.28 stddev:24079.69 (98.8%) stddev-sans-first:24112.55 09:10:21 INFO - PROCESS | 1643 | Values: 697.0 699.6 744.3 752.0 797.1 14508.8 15166.2 15196.0 15210.2 15222.4 11446.8 13665.6 13884.7 14190.4 14367.1 901.5 908.2 909.0 909.6 909.8 894.9 908.2 909.6 915.0 924.7 968.1 969.6 970.2 972.7 973.2 965.2 967.4 968.0 968.4 969.0 716.0 718.0 718.2 718.5 719.2 13834.0 15231.6 15260.8 15279.2 15320.7 13628.4 13835.5 13861.5 13945.2 14179.9 11314.9 11465.4 11486.4 11646.7 12194.8 3522.0 3529.3 3533.9 3592.1 3631.3 79947.0 92937.5 95511.0 95730.0 96565.6 10397.4 10567.6 10662.7 10812.8 10856.0 21666.8 21985.7 22004.6 22053.0 22106.7 7333.9 7405.0 7409.7 7569.5 7575.1 3938.9 4022.6 4063.6 4075.2 4169.3 3555.3 3650.5 3652.8 3665.3 3667.9 638.2 641.4 645.9 667.9 670.3 505.5 617.9 618.3 620.4 668.2 9345.0 9904.1 9953.2 10096.3 10775.6 540.9 580.1 580.4 623.9 670.1 4393.2 4813.4 4874.8 4940.4 4945.4 69210.7 84333.6 88525.0 89668.6 92175.5 52296.5 52754.7 56014.4 74554.3 74930.0 35752.8 66335.4 68078.7 68171.0 69111.0 10092.8 10457.7 10472.5 10587.5 10599.9 40681.4 44329.3 44560.9 44671.0 45435.5 59067.4 59493.7 60510.1 61500.8 62409.0 11823.6 11829.8 12104.5 12168.4 12357.5 14228.5 14291.9 14318.9 14387.9 14988.9 13322.2 13421.5 13635.9 13736.2 13807.9 13204.7 13238.3 13360.7 13478.2 14005.4 12799.5 13376.3 13821.5 13909.4 13923.8 9941.7 10123.1 10446.2 10585.5 11698.8 5895.9 8771.0 9985.4 10837.3 10932.2 09:10:21 INFO - PROCESS | 1643 | -------- Summary: end -------- 09:10:21 INFO - PROCESS | 1643 | 09:10:22 INFO - TEST-INFO | 1643: exit 0 09:10:22 INFO - TEST-OK | dromaeo_css | took 1121683ms 09:10:22 INFO - TEST-START | kraken 09:10:22 INFO - operating with platform_type : mac_ 09:10:22 INFO - Initialising browser for kraken test... 09:10:22 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmp3Rskj7/profile http://localhost:49240/getInfo.html) 09:10:24 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 09:10:24 INFO - PROCESS | 1649 | colorDepth:24 09:10:24 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 09:10:24 INFO - PROCESS | 1649 | __metrics 09:10:25 INFO - PROCESS | 1649 | 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" 09:10:25 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:10:26 INFO - TEST-INFO | 1649: exit 0 09:10:26 INFO - Browser initialized. 09:10:26 INFO - Running cycle 1/1 for kraken test... 09:10:26 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/T/tmp3Rskj7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:38 INFO - PROCESS | 1650 | RSS: Main: 231227392 09:10:38 INFO - PROCESS | 1650 | 09:10:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 09:10:41 INFO - PROCESS | 1650 | RSS: Main: 283889664 09:10:41 INFO - PROCESS | 1650 | 09:10:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 09:10:45 INFO - PROCESS | 1650 | RSS: Main: 285995008 09:10:45 INFO - PROCESS | 1650 | 09:10:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 09:10:49 INFO - PROCESS | 1650 | RSS: Main: 378064896 09:10:49 INFO - PROCESS | 1650 | 09:10:51 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 09:10:52 INFO - PROCESS | 1650 | RSS: Main: 279568384 09:10:52 INFO - PROCESS | 1650 | 09:10:54 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:10:54 INFO - PROCESS | 1650 | RSS: Main: 282324992 09:10:54 INFO - PROCESS | 1650 | 09:10:57 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 09:10:58 INFO - PROCESS | 1650 | RSS: Main: 325816320 09:10:58 INFO - PROCESS | 1650 | 09:11:01 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:02 INFO - PROCESS | 1650 | RSS: Main: 328933376 09:11:02 INFO - PROCESS | 1650 | 09:11:04 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 09:11:05 INFO - PROCESS | 1650 | RSS: Main: 326266880 09:11:05 INFO - PROCESS | 1650 | 09:11:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:07 INFO - PROCESS | 1650 | RSS: Main: 299982848 09:11:07 INFO - PROCESS | 1650 | 09:11:09 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:11:10 INFO - PROCESS | 1650 | RSS: Main: 303812608 09:11:10 INFO - PROCESS | 1650 | 09:11:12 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:11:13 INFO - PROCESS | 1650 | RSS: Main: 305606656 09:11:13 INFO - PROCESS | 1650 | 09:11:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:11:16 INFO - PROCESS | 1650 | RSS: Main: 323411968 09:11:16 INFO - PROCESS | 1650 | 09:11:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:11:20 INFO - PROCESS | 1650 | RSS: Main: 318083072 09:11:20 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 09:11:22 INFO - PROCESS | 1650 | RSS: Main: 362450944 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | __start_tp_report 09:11:22 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 09:11:22 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 09:11:22 INFO - PROCESS | 1650 | |i|pagename|runs| 09:11:22 INFO - PROCESS | 1650 | |0;ai-astar;116;115;114;115;113;115;114;114;115;115 09:11:22 INFO - PROCESS | 1650 | |1;audio-beat-detection;143;114;93;174;145;147;108;138;162;112 09:11:22 INFO - PROCESS | 1650 | |2;audio-dft;188;258;211;186;184;183;184;185;184;185 09:11:22 INFO - PROCESS | 1650 | |3;audio-fft;83;61;62;91;61;62;60;59;93;90 09:11:22 INFO - PROCESS | 1650 | |4;audio-oscillator;88;72;71;70;93;102;122;99;68;86 09:11:22 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;89;89;89;89;90;89;88;90;89;88 09:11:22 INFO - PROCESS | 1650 | |6;imaging-darkroom;96;96;96;97;95;95;108;153;152;95 09:11:22 INFO - PROCESS | 1650 | |7;imaging-desaturate;86;86;87;87;85;86;87;85;87;86 09:11:22 INFO - PROCESS | 1650 | |8;json-parse-financial;65;62;60;59;60;61;61;61;60;60 09:11:22 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;64;78;80;75;73;69;69;71;70;72 09:11:22 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;89;89;89;87;88;88;88;88;89;86 09:11:22 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;145;142;142;141;141;142;141;139;181;157 09:11:22 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;179;178;178;181;183;177;239;220;179;179 09:11:22 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;68;66;69;69;69;66;67;66;66;66 09:11:22 INFO - PROCESS | 1650 | __end_tp_report 09:11:22 INFO - PROCESS | 1650 | __start_cc_report 09:11:22 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2122 09:11:22 INFO - PROCESS | 1650 | __end_cc_report 09:11:22 INFO - PROCESS | 1650 | __startTimestamp1488042682509__endTimestamp 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | ------- Summary: start ------- 09:11:22 INFO - PROCESS | 1650 | Number of tests: 14 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.60 Median:115.00 stddev:0.84 (0.7%) stddev-sans-first:0.73 09:11:22 INFO - PROCESS | 1650 | Values: 116.0 115.0 114.0 115.0 113.0 115.0 114.0 114.0 115.0 115.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:133.60 Median:146.00 stddev:25.84 (17.7%) stddev-sans-first:27.19 09:11:22 INFO - PROCESS | 1650 | Values: 143.0 114.0 93.0 174.0 145.0 147.0 108.0 138.0 162.0 112.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:194.80 Median:185.50 stddev:23.71 (12.8%) stddev-sans-first:25.03 09:11:22 INFO - PROCESS | 1650 | Values: 188.0 258.0 211.0 186.0 184.0 183.0 184.0 185.0 184.0 185.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:72.20 Median:72.50 stddev:14.91 (20.6%) stddev-sans-first:15.30 09:11:22 INFO - PROCESS | 1650 | Values: 83.0 61.0 62.0 91.0 61.0 62.0 60.0 59.0 93.0 90.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:87.10 Median:79.00 stddev:17.52 (22.2%) stddev-sans-first:18.58 09:11:22 INFO - PROCESS | 1650 | Values: 88.0 72.0 71.0 70.0 93.0 102.0 122.0 99.0 68.0 86.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:89.00 Median:89.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 09:11:22 INFO - PROCESS | 1650 | Values: 89.0 89.0 89.0 89.0 90.0 89.0 88.0 90.0 89.0 88.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:108.30 Median:95.50 stddev:23.62 (24.7%) stddev-sans-first:24.63 09:11:22 INFO - PROCESS | 1650 | Values: 96.0 96.0 96.0 97.0 95.0 95.0 108.0 153.0 152.0 95.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:86.20 Median:86.50 stddev:0.79 (0.9%) stddev-sans-first:0.83 09:11:22 INFO - PROCESS | 1650 | Values: 86.0 86.0 87.0 87.0 85.0 86.0 87.0 85.0 87.0 86.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:1.66 (2.7%) stddev-sans-first:0.88 09:11:22 INFO - PROCESS | 1650 | Values: 65.0 62.0 60.0 59.0 60.0 61.0 61.0 61.0 60.0 60.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.50 stddev:4.68 (6.5%) stddev-sans-first:3.94 09:11:22 INFO - PROCESS | 1650 | Values: 64.0 78.0 80.0 75.0 73.0 69.0 69.0 71.0 70.0 72.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:88.50 stddev:0.99 (1.1%) stddev-sans-first:1.00 09:11:22 INFO - PROCESS | 1650 | Values: 89.0 89.0 89.0 87.0 88.0 88.0 88.0 88.0 89.0 86.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:147.10 Median:142.00 stddev:12.94 (9.1%) stddev-sans-first:13.70 09:11:22 INFO - PROCESS | 1650 | Values: 145.0 142.0 142.0 141.0 141.0 142.0 141.0 139.0 181.0 157.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.30 Median:180.00 stddev:21.72 (12.1%) stddev-sans-first:22.72 09:11:22 INFO - PROCESS | 1650 | Values: 179.0 178.0 178.0 181.0 183.0 177.0 239.0 220.0 179.0 179.0 09:11:22 INFO - PROCESS | 1650 | 09:11:22 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.40 (2.1%) stddev-sans-first:1.45 09:11:22 INFO - PROCESS | 1650 | Values: 68.0 66.0 69.0 69.0 69.0 66.0 67.0 66.0 66.0 66.0 09:11:22 INFO - PROCESS | 1650 | -------- Summary: end -------- 09:11:22 INFO - PROCESS | 1650 | 09:11:23 INFO - TEST-INFO | 1650: exit 0 09:11:23 INFO - TEST-OK | kraken | took 61059ms 09:11:23 INFO - SUITE-END | took 1182s 09:11:23 INFO - Completed test suite (00:19:42) 09:11:23 INFO - javascript benchmark 09:11:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7106.94923322624, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.671632836716, 3295.719863811574, 3296.604407471104, 3335.5330253764478, 3336.582927134108, 5410.594205434589, 5495.6153069285165, 5516.889662206753, 5616.887662246752, 5625.887482250352, 5505.834824955257, 5567.025770490169, 5598.964191624552, 5617.38208797032, 5649.378568357477, 4204.306289462235, 5065.316182315396, 5106.897862042757, 5113.079645663779, 5172.32759741235, 5243.659162154448, 5245.213218017289, 5255.632105752599, 5260.368755749316, 5278.815241466549, 4997.775100120467, 5022.799088036474, 5038.244263360525, 5177.068127737025, 5249.632525723201, 5083.415407228179, 5088.338515992898, 5122.231665250242, 5130.435652078306, 5193.2989046479, 5042.445331013586, 5072.822451214227, 5082.517160869711, 5108.591312694975, 5126.102931986888, 5418.566514678816, 5573.972130139364, 5581.413951535112, 5587.7485513152005, 5596.608237423382, 6052.12244224585, 6097.969510152465, 6106.664133472657, 6110.633361998294, 6116.724747386378, 5015.724135172564, 5167.48325167484, 6119.593952096689, 6127.403330890726, 6172.0, 5683.948469533149, 5688.431156884279, 5695.800646977336, 5703.600747947646, 5704.344000440003, 6144.310314663503, 6217.0, 6217.440430361289, 6238.0, 6252.280987686383, 6024.427679370453, 6031.4270144336215, 6031.7587296507645, 6036.909446358308, 6040.365761595057, 6122.825106970096, 6132.581522417052, 6144.5084393248435, 6152.384761523901, 6195.473384762256, 5173.482651734872, 6171.691415429211, 6191.597546159485, 6198.597091189058, 6201.131841542187, 6190.81427557174, 6195.19462469876, 6209.348018458088, 6211.503079753609, 6220.813375598739, 4811.08589368019, 4875.463698993108, 4877.146499362669, 4904.975475122602, 4964.404271487445, 4353.325234588644, 4356.259435895905, 4363.890902727394, 4453.398791163217, 4464.196444639931, 5406.351237851404, 5506.2841830562575, 5527.834164975057, 5563.054280772279, 5569.916451253234, 6021.337652858182, 6055.394460553909, 6177.227846519185, 6179.536534759911, 6246.375362463808, 5677.091665333527, 5686.829395118153, 5691.459311365414, 5692.9146062809095, 5721.685307308055, 5213.165893457029, 5357.973210133924, 5369.140937450067, 5387.057264978613, 5393.056215162331, 6171.13604095427, 6221.09794079865, 6234.064890266496, 6241.968790156111, 6242.750289988349, 6080.935836228731, 6090.634561926121, 6100.847478813065, 6114.991026480581, 6116.847078823065, 5009.250731500603, 6178.382161783786, 6209.5032397409, 6232.688365581612, 6247.5939063960695, 6127.617148554337, 6137.355577664281, 6139.022574051671, 6144.525313924537, 6149.169862068564, 6196.845078873064, 6204.5036397089025, 6213.0, 6213.409726076015, 6215.06773983906, 5776.249087618583, 5840.737166827418, 6018.157457955977, 6024.427679370453, 6067.120267561268, 5884.6469211845715, 5899.380565040609, 5900.055991041413, 5900.380460051804, 5902.38025007368, 5268.947310526845, 5571.415001424954, 5662.915056274242, 5751.568632352507, 5757.625754325955, 5849.53203743708, 5900.262467191601, 5901.468867801918, 5916.55625828056, 5916.792912248051, 5717.142428635738, 5753.626014309224, 5824.097264923944, 5843.532517398683, 5875.588708790344], "value": 5577.146768613216, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [456.89034631688406, 457.6384656121664, 477.4032459425718, 478.514307977403, 483.5116532302378, 39414.817555473346, 41303.0, 41500.79249603755, 41532.377014344806, 41705.0, 41851.581484185226, 42299.36550951738, 42349.576504234945, 42377.576224237746, 42411.575884241145, 7590.5066170699, 9514.666986655451, 9761.219102471821, 9761.609535618602, 9772.218222542215, 7634.809129771745, 7768.922310776905, 7778.4166187535875, 7779.727709530168, 11387.430628468584, 9980.201583873273, 11599.768004639902, 11858.407079646026, 11866.466009029571, 11876.524939002473, 11682.240654357482, 11768.352740599265, 11769.2938423694, 11772.587959421378, 11779.823302650424, 7499.137599176055, 11375.601853935155, 11591.362475063868, 11592.826107608393, 11596.76806463866, 28056.719432805614, 39065.0, 39920.60079399198, 40352.0, 41907.37138942918, 3756.7558108722847, 3789.5263092113487, 3806.2042523527307, 3828.119532507511, 3845.134844659929, 20544.897275513675, 27308.45383092347, 29576.81692732288, 29756.256093597618, 30275.545866812015, 3121.438141134595, 3171.762117841148, 3190.6490286068515, 3237.611486621597, 3248.0742988248235, 443963.0, 445980.0, 446070.0, 446374.0, 446577.0, 49270.50729492731, 51307.0, 51321.486785131674, 62485.0, 63133.5806493541, 68477.31522684709, 68966.65516672484, 70013.0, 70028.0, 70436.94344584836, 15229.923850380677, 15487.0, 15521.84478155204, 15525.068495890057, 15560.610984725472, 11773.411329433666, 12001.87998120025, 12002.0, 12005.2196607222, 12012.099092568093, 18023.0, 18027.008514531564, 18046.368377107, 18061.458156255332, 18075.00587467702, 5438.226504482743, 6533.085368048477, 6560.507961902877, 6587.5626018373505, 6605.471562275006, 819.7499762572472, 857.2156476823636, 861.2248975921596, 870.3680598877105, 891.8840550728364, 26480.867595661897, 28931.85534072358, 28958.0, 29734.553981690293, 29757.702422975493, 896.5248418338291, 920.7329874336367, 1030.1861529391847, 1078.7141407527013, 1208.8428504294561, 12438.315892625993, 13508.257045862572, 14590.927045364706, 14743.926280368529, 15007.474738384322, 790148.0, 808338.0, 809084.0, 809857.0, 810399.0, 51332.74333628308, 51802.48197517976, 51821.48178518242, 51828.96342073137, 51846.48153518492, 1355.2817006986313, 1378.7725025370903, 1403.5508637235987, 1406.951820893441, 1407.4088882669098, 23376.0, 25514.23457296284, 27317.487690885166, 28095.157145285673, 28108.578371324857, 44246.557534424246, 44562.66312010645, 44617.55382446134, 44622.3306650394, 44894.0, 429761.0, 431997.0, 434143.0, 434997.0, 436140.0, 20403.693944590545, 21065.894670526548, 21660.45848853791, 21670.783292166878, 24127.276181714577, 40331.79834100811, 40827.7958610205, 40922.79538602288, 41251.1749765009, 41407.585924140374, 32800.83599581987, 33603.32793344168, 33954.66045339515, 35135.47296790499, 35442.29115417626, 33825.0, 33842.66157338395, 35014.29971400608, 35320.646793531734, 35379.11552211215, 33470.66529334773, 33887.661123388454, 34563.48154777731, 34593.48109778305, 34772.304553909285, 28809.70356333928, 30161.849190753906, 30783.846080769454, 30806.691933080383, 30828.53757193599, 23228.65157022612, 23381.649275260545, 23423.656986164777, 23632.29103126909, 23890.88054559716], "value": 19042.02791487589, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.53732878593456, 377.2812791631942, 385.8225216400456, 389.66683485619797, 409.01631576059566, 14260.215688137148, 14648.70702585949, 20161.39515814526, 20983.790162098376, 21298.89350553245, 20650.586988260227, 21471.0, 21529.892350538266, 21593.892030539864, 21734.239301624446, 5348.786048558053, 5627.352854421732, 5649.0, 5652.236948012028, 5652.236948012028, 5475.945240547583, 5618.297712785902, 6182.536309776762, 6231.252249730039, 6232.626042437446, 6197.411245931629, 6199.016314779273, 6207.099970504274, 6208.627482351051, 6215.316315205324, 5504.091824848895, 5514.696691681956, 5575.498205161555, 5580.107182850765, 5601.0, 4724.126036683225, 5447.019536483432, 5453.563714902798, 5459.12653975366, 5470.17947307903, 12364.62906112818, 12693.492260309577, 20638.071286792132, 25506.744932550624, 27005.729942700713, 2589.184406911817, 2598.428345763929, 2662.60060990851, 2682.6244325794405, 2881.5965764792945, 15622.843771562253, 16770.22043228076, 16823.495295141165, 17309.826901731074, 18090.366837160767, 1921.8270355667917, 1951.388545121523, 1957.559549101455, 1969.5371587676884, 1988.801119888014, 149162.99999999892, 150504.0, 159068.0, 161948.0, 163073.0, 16648.417305394254, 22578.661320080213, 22601.434964126027, 22677.124418250154, 22933.0, 39667.809965701075, 40478.0, 40641.12306523177, 40691.0, 40760.4783234681, 10935.890641093647, 11039.613613523488, 11067.0, 11124.666260012213, 11277.94361028206, 8693.348793506742, 8739.825203495895, 8850.822983540293, 8939.955300223457, 9181.219596334253, 10489.737756556147, 10644.254902156774, 10694.0, 10794.892051079389, 10799.514021869034, 3561.3467966365224, 4139.937900931488, 4203.97898010508, 4278.700490965664, 4283.443152390231, 736.5249414127965, 852.2713080316364, 857.7255278311005, 860.264473874828, 873.3321437776208, 15985.760213596805, 19520.31678891232, 22669.2065777697, 22712.205072822704, 22775.886120569292, 862.1680078724062, 885.1723638398119, 905.0949050949051, 906.6418764587951, 911.5715613661569, 10428.791424171473, 11390.031847292907, 11687.76624467523, 11691.941540292244, 11710.414479276002, 516981.0, 703630.0, 709167.0, 719425.0, 727785.0, 121136.0, 133179.66820331867, 133524.0, 143063.56936430503, 158784.20607896885, 438.61840199026415, 458.9632829373642, 459.37983721975735, 461.53385081068365, 461.5430723583628, 11046.226764126433, 11336.94331528337, 11518.884811151782, 11537.653870383901, 11905.226160299553, 57494.0, 59027.524311890826, 59424.21727348187, 59673.40326596679, 60462.69768651129, 84970.57514712386, 86427.56786216029, 87089.56455217683, 87910.0, 88979.0, 6962.582245065312, 8253.546054967035, 8517.659293628185, 8529.360297977553, 8842.381033327863, 12609.810852837398, 13132.606021819362, 13304.600861974157, 13501.122427042212, 13764.793528097287, 5710.200571919851, 6745.662716864235, 11027.0, 11042.779144417227, 11344.773104537699, 10317.123044541298, 10643.94678026605, 11042.447877605928, 11495.907888750555, 11578.594749183738, 11257.549698011988, 11336.6032188873, 11613.6515904523, 11658.00906922887, 11735.061195104541, 7118.323759242864, 8322.37582181351, 8505.106963768716, 8594.484330940164, 8608.865235846108, 8771.912280877365, 10872.293300935415, 11394.772104558027, 11408.657740267805, 11503.539858405904], "value": 10439.138099832044, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1430.9427622895084, 1443.0129234686015, 1449.304333919719, 1450.9782353264702, 1459.3287087939548, 7997.160298168688, 8390.958045209773, 8393.454425462342, 8394.58027098645, 8407.621657025433, 8135.023797144336, 8236.17638236176, 8366.665333386673, 8382.455140415885, 8469.44948578342, 2237.1498830444407, 2281.8060464860505, 2281.954360912789, 2286.0969916882823, 2286.748457669655, 2243.798058174764, 2274.3631783100677, 2277.954440911181, 2280.703508543887, 2282.1556024271044, 2241.618924782783, 2244.618414869476, 2269.6822444857735, 2274.033535747309, 2278.054607337953, 2184.868907865533, 2201.515666553356, 2226.1206823304865, 2227.40973641985, 2229.141780414536, 2201.9119235230573, 2232.0625337358347, 2242.5066485373354, 2244.640857462798, 2244.921427750021, 8326.0, 8370.330373570161, 8403.453775504633, 8406.28546573542, 8407.327413806943, 5001.874953126165, 5152.92270615941, 5163.380394352665, 5165.974170129125, 5170.25031370453, 2561.948761024788, 3061.663217046123, 3197.4404479216046, 3241.97877668536, 3243.5459035735016, 900.459724165502, 922.2437601167046, 1061.4268295120626, 1110.6890070780114, 1134.155054484406, 9667.951660241724, 9978.201743860474, 9996.400215987136, 10776.946115269373, 10872.45637718111, 3918.804059796999, 4244.533101358848, 4392.780360982002, 4396.3625274335045, 4410.33844923264, 8697.91302086971, 8716.0, 8730.257928076184, 8730.337247139556, 8758.080401557872, 4323.7621930793475, 4479.148961697332, 4826.806927722922, 4960.503949605083, 5053.2420136979745, 4583.816647334136, 4686.976565117153, 4736.076465089274, 4743.620510359232, 4755.500672429414, 3537.25717599307, 3601.513795637555, 3618.16782140104, 3670.9082272942856, 3674.2284120334493, 1130.9773804523863, 1131.1007748839693, 1134.6028889888473, 1147.942602869853, 1149.080735411684, 757.9052618422697, 822.6056833666996, 857.6697971281102, 869.6390997735868, 872.8739925496039, 5127.846444380064, 5215.374155101412, 5240.0, 5563.972180139073, 5582.553395728332, 573.9913901291484, 578.6788332475517, 584.1967294969417, 592.2123575644382, 594.7918228619949, 3394.62659107498, 3479.634638362986, 3587.766795158306, 3591.586967498719, 3597.5503062117236, 9586.520673966414, 9819.214462842956, 9910.653127140515, 9931.056549627774, 9947.403155810674, 9861.901380986243, 9884.0, 9889.20886329092, 9900.752481187883, 9901.306908516479, 6493.967530162319, 7521.962390188014, 7708.884366734504, 7804.453688241769, 7818.179091195342, 5193.195054766517, 5248.265242866079, 5324.121519949165, 5382.111951528111, 5394.622376433769, 8929.73210803677, 9183.31125165602, 9203.907960920305, 9215.49314787693, 9228.215601673664, 7656.272654097852, 7829.0, 7857.489263197874, 8754.080821513904, 9294.535273236446, 7036.542624729376, 7222.3860971817985, 7224.638768061681, 7225.277472252733, 7237.746678866214, 7711.498752581064, 7827.726029588937, 7867.331276841533, 7887.369010479033, 7914.24814642608, 7058.929410705828, 7070.222275549582, 7093.1488221413765, 7141.250168732416, 7245.0, 5657.830265092054, 6926.341997510229, 6959.860802784017, 7049.330313620198, 7053.6825842838225, 6332.208473940757, 6448.258450278278, 6451.612903225821, 6451.870962580629, 6456.709448074942, 4616.469106052847, 4730.219513780187, 4791.305260737104, 4844.079624871404, 4891.682040667345, 4659.114768194032, 4718.127146477913, 4827.517248275144, 4938.358013458371, 4965.602751779921], "value": 4209.336454230475, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.9442392005318, 353.90995733141915, 362.90564453242155, 363.4911124425805, 365.70377993825, 5076.695398276106, 5148.665336753108, 5148.794048238066, 5152.505773325731, 5185.688858668483, 4140.565240649726, 4973.204287314031, 5070.822521211759, 5139.331886854713, 5150.536451719354, 2796.566532187514, 3883.8834834954855, 4083.8979025524304, 4087.3664581989838, 4099.631033207011, 3096.845157742115, 3481.267205243884, 3929.607039296076, 3935.311320518912, 3941.3840325466563, 3731.813409329536, 3877.111551893843, 3894.9805250973704, 3921.0393453603906, 3939.8227079781477, 3900.980495097535, 3915.921681566367, 3917.3928041153667, 3952.841886324544, 3965.8413663453425, 2692.892284308625, 3119.4385010698065, 3410.4202285611505, 3436.553248077759, 3453.2920751246183, 4918.360613120271, 4942.975285123552, 4954.5540901319055, 4954.628402869763, 4954.950450495521, 4448.132614140244, 4453.332000199964, 4472.351509031172, 4473.2842745160615, 4474.865754027352, 4235.830566777326, 4925.532074452921, 4983.501649834988, 5146.536811686966, 5508.862278443031, 3671.7980511071883, 3713.962860371416, 3757.647246991081, 3760.9435858462143, 3767.9811600942094, 4498.910021799546, 5282.705737094398, 5584.956198871625, 5678.772849086032, 5828.679422631753, 3197.840107994591, 3356.6139893912023, 3555.0, 3769.7946701180117, 3772.8113594320175, 3181.9522707159413, 3667.0, 3831.8467261309793, 3833.1950290438763, 3847.788371639587, 3602.8018458984484, 4085.080856807195, 4174.7893110997475, 4309.534758182233, 4485.820567177277, 4580.931286030645, 4806.351142595775, 5374.838754837361, 5435.592330575223, 5481.5340696041285, 1060.1624716474053, 1141.9143564232716, 1223.2049168040667, 1230.2188110549687, 1244.8381710377773, 771.6141929035482, 790.5256845892419, 838.6058552480324, 839.5811079276004, 860.8923884514436, 4244.8089835956835, 4504.941338785383, 4765.499622539653, 4816.242071643825, 4817.13291607507, 4473.530279320689, 4967.428745694219, 5000.74996250186, 5377.924415116992, 5414.160805075219, 4109.445224894661, 4160.908340707331, 4344.435223420998, 4837.4920633332995, 4877.731789734695, 2491.327341617753, 2552.659853576887, 2652.9307140430496, 2721.986390068037, 2798.874050667725, 4575.839845605387, 5121.206213036985, 5126.5898728101665, 5409.0, 5477.233187353773, 4788.880277993008, 5123.87190320245, 5220.455420331029, 5428.67427954324, 5492.862678433071, 4429.800658970354, 4462.898285691478, 4763.69036012665, 5145.9742701287005, 5523.25436066142, 4427.339747594652, 4649.814007439664, 5251.894962100813, 5293.761780719954, 5332.22682710997, 4285.5928686774705, 4885.95114048855, 4992.675476094042, 5143.948560514347, 5314.5482633975, 4743.83396581118, 4872.588068905914, 5124.410692770379, 5330.733463326896, 5460.399356070909, 2955.482790511695, 3249.5288183213775, 3579.4451859961746, 3603.153258984189, 3613.674769270778, 4621.79201935907, 5312.0, 5482.917756233739, 5530.253415788817, 5532.474414930736, 3862.3820188769664, 5326.946730532645, 5327.547158491571, 5369.979703856255, 5468.671879687232, 5313.867153321044, 5322.600804939722, 5363.800841654903, 5371.194320851903, 5385.9192112119135, 4478.820847166207, 4518.299663552155, 5059.898802024012, 5264.842054738364, 5412.323459567554, 4775.6657034007285, 5145.948540514547, 5329.626926115135, 5410.0, 5443.319585051869, 4463.928657122202, 4847.830325938575, 5003.799848006184, 5049.924251136309, 5163.948360516347], "value": 3831.954960776425, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.9930300696994, 699.6326928362606, 744.3226663736, 752.0290877301039, 797.0833541427357, 14508.782368264472, 15166.165860877647, 15196.012259203144, 15210.16344101074, 15222.391104355826, 11446.828297575543, 13665.590032299022, 13884.722305553883, 14190.43238270468, 14367.137971721704, 901.4591245252861, 908.2098574240387, 908.9727308180732, 909.5997760985179, 909.7725568607848, 894.8702438146497, 908.2007833106857, 909.6315992023241, 914.9817003659923, 924.6809850601531, 968.0658164870898, 969.60730903984, 970.1656575345197, 972.6984634763211, 973.1873885305778, 965.2278177458005, 967.3953778888194, 967.9612815487337, 968.3512046928504, 969.0406497567428, 715.9606221657859, 718.0485856240502, 718.195620904585, 718.5257729898242, 719.1765428584295, 13834.0, 15231.619209519851, 15260.847391526053, 15279.159646219454, 15320.693586128327, 13628.35557944402, 13835.515756948458, 13861.514846980308, 13945.16329020262, 14179.858201417957, 11314.886851131549, 11465.426728663533, 11486.368249746261, 11646.650600481998, 12194.81707774384, 3522.0, 3529.2764983178645, 3533.896867296726, 3592.0660628236847, 3631.346357655621, 79947.0, 92937.535312323, 95511.0448895509, 95730.0, 96565.55151672731, 10397.425966751962, 10567.577296908037, 10662.73343166427, 10812.837807432894, 10856.0, 21666.783332166793, 21985.67021494679, 22004.559908802054, 22053.0, 22106.668399974013, 7333.853322933512, 7405.037345145097, 7409.666565004588, 7569.47013709035, 7575.128860181039, 3938.8621398250925, 4022.577629348876, 4063.5733248009124, 4075.2053349596545, 4169.291220492523, 3555.253396786704, 3650.470681751131, 3652.7625704329134, 3665.2852693724467, 3667.889963301052, 638.2404938123618, 641.3938827807677, 645.8514541655352, 667.9332066793281, 670.2928410526941, 505.5062290930292, 617.9032217813417, 618.2920555963397, 620.3951147631113, 668.1781408867121, 9345.0, 9904.105781448534, 9953.203743700487, 10096.34373765703, 10775.622853200257, 540.9080456322434, 580.1001719369016, 580.4137820801021, 623.8533944523033, 670.0920253057135, 4393.231184542692, 4813.374261346003, 4874.775719561253, 4940.382452193476, 4945.406551213878, 69210.65394672994, 84333.57833210917, 88525.0, 89668.5516572413, 92175.53912230396, 52296.47703522916, 52754.73622631939, 56014.43985560174, 74554.25445745581, 74930.0, 35752.82123589365, 66335.39130652117, 68078.65960670264, 68171.0, 69110.999999999, 10092.84860727075, 10457.68626941193, 10472.476376181008, 10587.523561439599, 10599.947000265258, 40681.38977915393, 44329.33505997477, 44560.88597785081, 44671.0, 45435.545644543134, 59067.40932590791, 59493.70253148706, 60510.09234861393, 61500.76998460095, 62409.0, 11823.586174483851, 11829.76340473203, 12104.515819367127, 12168.391580421121, 12357.505699771908, 14228.502002429865, 14291.857081429052, 14318.916784541338, 14387.856121438652, 14988.850111498745, 13322.200667959953, 13421.463141474233, 13635.931820340835, 13736.244506552235, 13807.86192138106, 13204.669883252996, 13238.338083096, 13360.665983350495, 13478.19130852152, 14005.43978240859, 12799.488020479077, 13376.264305463294, 13821.516246931309, 13909.443622254996, 13923.791143133063, 9941.65204217849, 10123.088921997056, 10446.164306855282, 10585.523651435858, 11698.824517632413, 5895.911561326498, 8771.0, 9985.350952188375, 10837.349759014485, 10932.234743567873], "value": 7204.816542297013, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 114.0, 115.0, 113.0, 115.0, 114.0, 114.0, 115.0, 115.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 93.0, 174.0, 145.0, 147.0, 108.0, 138.0, 162.0, 112.0], "value": 133.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 258.0, 211.0, 186.0, 184.0, 183.0, 184.0, 185.0, 184.0, 185.0], "value": 194.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 62.0, 91.0, 61.0, 62.0, 60.0, 59.0, 93.0, 90.0], "value": 72.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 71.0, 70.0, 93.0, 102.0, 122.0, 99.0, 68.0, 86.0], "value": 87.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 89.0, 90.0, 89.0, 88.0, 90.0, 89.0, 88.0], "value": 89.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 108.0, 153.0, 152.0, 95.0], "value": 108.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 87.0, 85.0, 86.0, 87.0, 85.0, 87.0, 86.0], "value": 86.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 60.0, 59.0, 60.0, 61.0, 61.0, 61.0, 60.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 78.0, 80.0, 75.0, 73.0, 69.0, 69.0, 71.0, 70.0, 72.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 87.0, 88.0, 88.0, 88.0, 88.0, 89.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 142.0, 142.0, 141.0, 141.0, 142.0, 141.0, 139.0, 181.0, 157.0], "value": 147.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 178.0, 178.0, 181.0, 183.0, 177.0, 239.0, 220.0, 179.0, 179.0], "value": 189.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 69.0, 69.0, 69.0, 66.0, 67.0, 66.0, 66.0, 66.0], "value": 67.2, "unit": "score"}]}]} 09:11:23 INFO - Return code: 0 09:11:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:11:23 ERROR - # TBPL SUCCESS # 09:11:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:11:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:11:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:11:23 INFO - 2017-02-25 09:11:23.823 screenresolution[1654:12800] starting screenresolution argv=screenresolution get 09:11:23 INFO - 2017-02-25 09:11:23.826 screenresolution[1654:12800] Display 0: 1600x1200x32@60 09:11:23 INFO - 2017-02-25 09:11:23.832 screenresolution[1655:12803] starting screenresolution argv=screenresolution list 09:11:23 INFO - Available Modes on Display 0 09:11:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:11:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:11:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:11:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:11:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:11:24 INFO - Intel Iris: 09:11:24 INFO - Chipset Model: Intel Iris 09:11:24 INFO - Type: GPU 09:11:24 INFO - Bus: Built-In 09:11:24 INFO - VRAM (Dynamic, Max): 1536 MB 09:11:24 INFO - Vendor: Intel (0x8086) 09:11:24 INFO - Device ID: 0x0a2e 09:11:24 INFO - Revision ID: 0x0009 09:11:24 INFO - Displays: 09:11:24 INFO - Display: 09:11:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:11:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:11:24 INFO - Display Serial Number: 1600x1200 60 09:11:24 INFO - Main Display: Yes 09:11:24 INFO - Mirror: Off 09:11:24 INFO - Online: Yes 09:11:24 INFO - Rotation: Supported 09:11:24 INFO - Return code: 0 09:11:24 INFO - Running post-action listener: _resource_record_post_action 09:11:24 INFO - [mozharness: 2017-02-25 17:11:24.067931Z] Finished run-tests step (success) 09:11:24 INFO - Running post-run listener: _resource_record_post_run 09:11:24 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 33680384; Write bytes: 516436992; Read time: 311; Write time: 1887 09:11:24 INFO - TinderboxPrint: CPU usage
53.7% 09:11:24 INFO - TinderboxPrint: I/O read bytes / time
33,680,384 / 311 09:11:24 INFO - TinderboxPrint: I/O write bytes / time
516,436,992 / 1,887 09:11:24 INFO - TinderboxPrint: CPU idle
2,229.1 (46.3%) 09:11:24 INFO - TinderboxPrint: CPU system
962.5 (20.0%) 09:11:24 INFO - TinderboxPrint: CPU user
1,626.0 (33.8%) 09:11:24 INFO - TinderboxPrint: Swap in / out
239,812,608 / 0 09:11:24 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 204194304; Write bytes: 205674496; Read time: 15600; Write time: 484 09:11:24 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 32697344; Write bytes: 300997632; Read time: 296; Write time: 1369 09:11:24 INFO - Running post-run listener: _upload_blobber_files 09:11:24 INFO - Blob upload gear active. 09:11:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:11:24 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 09:11:24 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'] 09:11:24 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 09:11:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:11:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:11:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:11:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:26 INFO - (blobuploader) - INFO - Done attempting. 09:11:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:11:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:11:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:26 INFO - (blobuploader) - INFO - Done attempting. 09:11:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:11:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:11:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:27 INFO - (blobuploader) - INFO - Done attempting. 09:11:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:11:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:11:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:11:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:11:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:11:30 INFO - (blobuploader) - INFO - Done attempting. 09:11:30 INFO - (blobuploader) - INFO - Iteration through files over. 09:11:30 INFO - Return code: 0 09:11:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:11:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:11:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40b9c7047c78974ce2317b8e883730f338f2a749bbcc4e2322b3bb94cb458508fa6fd82c856387c8a534de04dc354e47e13bf4dc991539a47e0b1eda596ef8ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6e6724d3bd2ead1c6306f32d2aa6b1be5e4de8c4ff93d93057aed7f72121236a0c3ca3cd65996b08aa7ff06207f2bcea0155ea2fc3f55d63d9d367974639be8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6a09117253e086220e1e6794a50cd6e9985926fff41ea039c836e9f151985efbabfd3bc1198fc7b2491d1c9e1b24d86cde0326387bbac1b33dbb81a310e5135", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d5ac6349f3ffa0f50f838903b066ae7e78b1efe28d34e612b6e04c2bf52c70ebb423102201deb1b2d1f5894ab21297d8beb241b9f0e1bec2942221677ee6509"} 09:11:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:11:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:11:30 INFO - Contents: 09:11:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/40b9c7047c78974ce2317b8e883730f338f2a749bbcc4e2322b3bb94cb458508fa6fd82c856387c8a534de04dc354e47e13bf4dc991539a47e0b1eda596ef8ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6e6724d3bd2ead1c6306f32d2aa6b1be5e4de8c4ff93d93057aed7f72121236a0c3ca3cd65996b08aa7ff06207f2bcea0155ea2fc3f55d63d9d367974639be8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6a09117253e086220e1e6794a50cd6e9985926fff41ea039c836e9f151985efbabfd3bc1198fc7b2491d1c9e1b24d86cde0326387bbac1b33dbb81a310e5135", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d5ac6349f3ffa0f50f838903b066ae7e78b1efe28d34e612b6e04c2bf52c70ebb423102201deb1b2d1f5894ab21297d8beb241b9f0e1bec2942221677ee6509"} 09:11:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:11:30 INFO - Copying logs to upload dir... 09:11:30 INFO - mkdir: /builds/slave/test/build/upload/logs 09:11:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.179392 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-02-25 09:11:30.106132) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-25 09:11:30.109845) ========= 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.HXOn0otHSp/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.NE33DWpuRA/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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/40b9c7047c78974ce2317b8e883730f338f2a749bbcc4e2322b3bb94cb458508fa6fd82c856387c8a534de04dc354e47e13bf4dc991539a47e0b1eda596ef8ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6e6724d3bd2ead1c6306f32d2aa6b1be5e4de8c4ff93d93057aed7f72121236a0c3ca3cd65996b08aa7ff06207f2bcea0155ea2fc3f55d63d9d367974639be8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6a09117253e086220e1e6794a50cd6e9985926fff41ea039c836e9f151985efbabfd3bc1198fc7b2491d1c9e1b24d86cde0326387bbac1b33dbb81a310e5135", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d5ac6349f3ffa0f50f838903b066ae7e78b1efe28d34e612b6e04c2bf52c70ebb423102201deb1b2d1f5894ab21297d8beb241b9f0e1bec2942221677ee6509"} build_url:https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010990 build_url: 'https://queue.taskcluster.net/v1/task/MHFsDpWlRbusx2ecoZOphg/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/40b9c7047c78974ce2317b8e883730f338f2a749bbcc4e2322b3bb94cb458508fa6fd82c856387c8a534de04dc354e47e13bf4dc991539a47e0b1eda596ef8ac", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6e6724d3bd2ead1c6306f32d2aa6b1be5e4de8c4ff93d93057aed7f72121236a0c3ca3cd65996b08aa7ff06207f2bcea0155ea2fc3f55d63d9d367974639be8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c6a09117253e086220e1e6794a50cd6e9985926fff41ea039c836e9f151985efbabfd3bc1198fc7b2491d1c9e1b24d86cde0326387bbac1b33dbb81a310e5135", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d5ac6349f3ffa0f50f838903b066ae7e78b1efe28d34e612b6e04c2bf52c70ebb423102201deb1b2d1f5894ab21297d8beb241b9f0e1bec2942221677ee6509"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-25 09:11:30.144301) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-25 09:11:30.144686) ========= 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.HXOn0otHSp/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.NE33DWpuRA/Listeners TMPDIR=/var/folders/qx/_j4hsj951qgdfkk93ckl0nxc00000w/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.005245 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-25 09:11:30.193185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-25 09:11:30.193509) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-25 09:11:30.193876) ========= ========= Total master_lag: 0.18 =========