builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0082 starttime: 1488758976.04 results: success (0) buildid: 20170305141116 builduid: 95140bcc70f1431db8294f228286d091 revision: 69efeba94b307f236a50a9e5fdd2bbd2e946657b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:36.040958) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:36.041437) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:36.041774) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:36.089198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:36.089487) ========= 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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-05 16:09:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 39.6M=0s 2017-03-05 16:09:36 (39.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.458388 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:36.573284) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:36.573641) ========= 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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.027500 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:36.622986) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-05 16:09:36.623367) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 69efeba94b307f236a50a9e5fdd2bbd2e946657b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 69efeba94b307f236a50a9e5fdd2bbd2e946657b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JMTaMtL74Z/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.cp5iLHw1ks/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-05 16:09:36,727 truncating revision to first 12 chars 2017-03-05 16:09:36,727 Setting DEBUG logging. 2017-03-05 16:09:36,727 attempt 1/10 2017-03-05 16:09:36,727 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/69efeba94b30?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-05 16:09:39,129 unpacking tar archive at: mozilla-aurora-69efeba94b30/testing/mozharness/ program finished with exit code 0 elapsedTime=2.685453 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-05 16:09:39.333737) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:39.334067) ========= script_repo_revision: 69efeba94b307f236a50a9e5fdd2bbd2e946657b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:39.334556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:39.334881) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 16:09:39.355356) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-05 16:09:39.355980) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.JMTaMtL74Z/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.cp5iLHw1ks/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:09:39 INFO - MultiFileLogger online at 20170305 16:09:39 in /builds/slave/test 16:09:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 16:09:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:09:39 INFO - {'append_to_log': False, 16:09:39 INFO - 'base_work_dir': '/builds/slave/test', 16:09:39 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 16:09:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:09:39 INFO - 'branch': 'Mozilla-Aurora', 16:09:39 INFO - 'buildbot_json_path': 'buildprops.json', 16:09:39 INFO - 'config_files': ('talos/mac_config.py',), 16:09:39 INFO - 'default_actions': ('clobber', 16:09:39 INFO - 'read-buildbot-config', 16:09:39 INFO - 'download-and-extract', 16:09:39 INFO - 'populate-webroot', 16:09:39 INFO - 'create-virtualenv', 16:09:39 INFO - 'install', 16:09:39 INFO - 'run-tests'), 16:09:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:09:39 INFO - 'download_minidump_stackwalk': True, 16:09:39 INFO - 'download_symbols': 'ondemand', 16:09:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:09:39 INFO - 'tooltool.py': '/tools/tooltool.py', 16:09:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:09:39 INFO - '/tools/misc-python/virtualenv.py')}, 16:09:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:09:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:09:39 INFO - 'installer_path': 'installer.exe', 16:09:39 INFO - 'log_level': 'info', 16:09:39 INFO - 'log_name': 'talos', 16:09:39 INFO - 'log_to_console': True, 16:09:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:09:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:09:39 INFO - 'opt_config_files': (), 16:09:39 INFO - 'pip_index': False, 16:09:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:09:39 INFO - 'cmd': ('bash', 16:09:39 INFO - '-c', 16:09:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:09:39 INFO - 'enabled': True, 16:09:39 INFO - 'halt_on_failure': False, 16:09:39 INFO - 'name': 'check_screen_resolution'},), 16:09:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:09:39 INFO - 'cmd': ('bash', 16:09:39 INFO - '-c', 16:09:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:09:39 INFO - 'enabled': True, 16:09:39 INFO - 'halt_on_failure': False, 16:09:39 INFO - 'name': 'check_screen_resolution'},), 16:09:39 INFO - 'run_cmd_checks_enabled': True, 16:09:39 INFO - 'sps_profile': False, 16:09:39 INFO - 'sps_profile_interval': 0, 16:09:39 INFO - 'suite': 'dromaeojs', 16:09:39 INFO - 'system_bits': '32', 16:09:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:09:39 INFO - 'title': 't-yosemite-r7-0082', 16:09:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:09:39 INFO - 'use_talos_json': True, 16:09:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:09:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:09:39 INFO - 'work_dir': 'build'} 16:09:39 INFO - [mozharness: 2017-03-06 00:09:39.571239Z] Running clobber step. 16:09:39 INFO - Running pre-action listener: _resource_record_pre_action 16:09:39 INFO - Running main action method: clobber 16:09:39 INFO - rmtree: /builds/slave/test/build 16:09:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:09:41 INFO - Running post-action listener: _resource_record_post_action 16:09:41 INFO - [mozharness: 2017-03-06 00:09:41.965359Z] Finished clobber step (success) 16:09:41 INFO - [mozharness: 2017-03-06 00:09:41.965525Z] Running read-buildbot-config step. 16:09:41 INFO - Running pre-action listener: _resource_record_pre_action 16:09:41 INFO - Running main action method: read_buildbot_config 16:09:41 INFO - Using buildbot properties: 16:09:41 INFO - { 16:09:41 INFO - "project": "", 16:09:41 INFO - "product": "firefox", 16:09:41 INFO - "script_repo_revision": "production", 16:09:41 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 16:09:41 INFO - "repository": "", 16:09:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 16:09:41 INFO - "buildid": "20170305141116", 16:09:41 INFO - "pgo_build": "False", 16:09:41 INFO - "basedir": "/builds/slave/test", 16:09:41 INFO - "buildnumber": 9, 16:09:41 INFO - "slavename": "t-yosemite-r7-0082", 16:09:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 16:09:41 INFO - "platform": "yosemite_r7", 16:09:41 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 16:09:41 INFO - "branch": "mozilla-aurora", 16:09:41 INFO - "repo_path": "releases/mozilla-aurora", 16:09:41 INFO - "revision": "69efeba94b307f236a50a9e5fdd2bbd2e946657b", 16:09:41 INFO - "stage_platform": "macosx64", 16:09:41 INFO - "builduid": "95140bcc70f1431db8294f228286d091", 16:09:41 INFO - "slavebuilddir": "test" 16:09:41 INFO - } 16:09:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 16:09:41 INFO - Running post-action listener: _resource_record_post_action 16:09:41 INFO - [mozharness: 2017-03-06 00:09:41.968916Z] Finished read-buildbot-config step (success) 16:09:41 INFO - [mozharness: 2017-03-06 00:09:41.969036Z] Running download-and-extract step. 16:09:41 INFO - Running pre-action listener: _resource_record_pre_action 16:09:41 INFO - Running main action method: download_and_extract 16:09:41 INFO - mkdir: /builds/slave/test/build/tests 16:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:09:41 INFO - trying https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 16:09:41 INFO - Downloading https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 16:09:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 16:09:43 INFO - Downloaded 1199 bytes. 16:09:43 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 16:09:43 INFO - Using the following test package requirements: 16:09:43 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:09:43 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:09:43 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 16:09:43 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:09:43 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 16:09:43 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:09:43 INFO - u'jsshell-mac.zip'], 16:09:43 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:09:43 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 16:09:43 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 16:09:43 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:09:43 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 16:09:43 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:09:43 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 16:09:43 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:09:43 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 16:09:43 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 16:09:43 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 16:09:43 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 16:09:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:09:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:09:43 INFO - Fetch https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:09:44 INFO - Expected file size: 16358040 16:09:44 INFO - Obtained file size: 16358040 16:09:51 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 16:09:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 16:09:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 16:09:51 INFO - Fetch https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 16:09:52 INFO - Expected file size: 16358040 16:09:52 INFO - Obtained file size: 16358040 16:09:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 16:09:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 16:09:58 INFO - Fetch https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 16:09:59 INFO - Expected file size: 14403650 16:09:59 INFO - Obtained file size: 14403650 16:09: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')]} 16:09:59 INFO - trying https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:09:59 INFO - Downloading https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 16:09:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 16:10:01 INFO - Downloaded 73951446 bytes. 16:10:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:10:01 INFO - mkdir: /builds/slave/test/properties 16:10:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:10:01 INFO - Writing to file /builds/slave/test/properties/build_url 16:10:01 INFO - Contents: 16:10:01 INFO - build_url:https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 16:10:02 INFO - Running post-action listener: _resource_record_post_action 16:10:02 INFO - Running post-action listener: set_extra_try_arguments 16:10:02 INFO - [mozharness: 2017-03-06 00:10:02.271656Z] Finished download-and-extract step (success) 16:10:02 INFO - [mozharness: 2017-03-06 00:10:02.271788Z] Running populate-webroot step. 16:10:02 INFO - Running pre-action listener: _resource_record_pre_action 16:10:02 INFO - Running main action method: populate_webroot 16:10:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:10:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:10:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:10:02 INFO - '--tppagecycles', 16:10:02 INFO - '7'], 16:10:02 INFO - 'tests': ['tsvgm']}}, 16:10:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:10:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:10:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:10:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:10:02 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 16:10:02 INFO - 'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:02 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 16:10:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:10:02 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 16:10:02 INFO - 'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['damp', 'tps']}, 16:10:02 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 16:10:02 INFO - 'tests': ['damp', 'tps']}, 16:10:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['dromaeo_dom']}, 16:10:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:10:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['basic_compositor_video']}, 16:10:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:10:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['a11yr', 16:10:02 INFO - 'ts_paint', 16:10:02 INFO - 'tpaint', 16:10:02 INFO - 'sessionrestore', 16:10:02 INFO - 'sessionrestore_no_auto_restore', 16:10:02 INFO - 'tabpaint']}, 16:10:02 INFO - 'other-e10s': {'tests': ['a11yr', 16:10:02 INFO - 'ts_paint', 16:10:02 INFO - 'tpaint', 16:10:02 INFO - 'sessionrestore', 16:10:02 INFO - 'sessionrestore_no_auto_restore', 16:10:02 INFO - 'tabpaint']}, 16:10:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:10:02 INFO - 'ts_paint', 16:10:02 INFO - 'tpaint', 16:10:02 INFO - 'sessionrestore', 16:10:02 INFO - 'sessionrestore_no_auto_restore', 16:10:02 INFO - 'tabpaint']}, 16:10:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:10:02 INFO - 'ts_paint', 16:10:02 INFO - 'tpaint', 16:10:02 INFO - 'sessionrestore', 16:10:02 INFO - 'sessionrestore_no_auto_restore', 16:10:02 INFO - 'tabpaint']}, 16:10:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['a11yr', 16:10:02 INFO - 'ts_paint', 16:10:02 INFO - 'tpaint', 16:10:02 INFO - 'sessionrestore', 16:10:02 INFO - 'sessionrestore_no_auto_restore', 16:10:02 INFO - 'tabpaint']}, 16:10:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['a11yr', 16:10:02 INFO - 'ts_paint', 16:10:02 INFO - 'tpaint', 16:10:02 INFO - 'sessionrestore', 16:10:02 INFO - 'sessionrestore_no_auto_restore', 16:10:02 INFO - 'tabpaint']}, 16:10:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['tsvgx', 16:10:02 INFO - 'tsvgr_opacity', 16:10:02 INFO - 'tart', 16:10:02 INFO - 'tscrollx', 16:10:02 INFO - 'cart', 16:10:02 INFO - 'tsvg_static']}, 16:10:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:10:02 INFO - 'tsvgr_opacity', 16:10:02 INFO - 'tart', 16:10:02 INFO - 'tscrollx', 16:10:02 INFO - 'cart', 16:10:02 INFO - 'tsvg_static']}, 16:10:02 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 16:10:02 INFO - 'talos_options': ['--disable-e10s'], 16:10:02 INFO - 'tests': ['tp5o']}, 16:10:02 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 16:10:02 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 16:10:02 INFO - 'talos_options': ['--disable-e10s', 16:10:02 INFO - '--xperf_path', 16:10:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:02 INFO - 'tests': ['tp5n']}, 16:10:02 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 16:10:02 INFO - 'talos_options': ['--xperf_path', 16:10:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:10:02 INFO - 'tests': ['tp5n']}}, 16:10:02 INFO - 'talos.zip': {'path': '', 16:10:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:10:02 INFO - Running post-action listener: _resource_record_post_action 16:10:02 INFO - [mozharness: 2017-03-06 00:10:02.290295Z] Finished populate-webroot step (success) 16:10:02 INFO - [mozharness: 2017-03-06 00:10:02.290425Z] Running create-virtualenv step. 16:10:02 INFO - Running pre-action listener: _resource_record_pre_action 16:10:02 INFO - Running main action method: create_virtualenv 16:10:02 INFO - Creating virtualenv /builds/slave/test/build/venv 16:10:02 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 16:10:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:10:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:10:02 INFO - Using real prefix '/tools/python27' 16:10:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:10:03 INFO - Installing distribute.............................................................................................................................................................................................done. 16:10:05 INFO - Installing pip.................done. 16:10:05 INFO - Return code: 0 16:10:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 16:10:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 16:10:06 INFO - Reading from file tmpfile_stdout 16:10:06 INFO - Output received: 16:10:06 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) 16:10:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:10:06 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')]} 16:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:06 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')]} 16:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:06 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 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10:06 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 16:10:06 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 16:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:06 INFO - 'HOME': '/Users/cltbld', 16:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:06 INFO - 'LOGNAME': 'cltbld', 16:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:06 INFO - 'MOZ_NO_REMOTE': '1', 16:10:06 INFO - 'NO_EM_RESTART': '1', 16:10:06 INFO - 'PAGER': '/bin/cat', 16:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:06 INFO - 'PWD': '/builds/slave/test', 16:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:06 INFO - 'SHELL': '/bin/bash', 16:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:06 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:06 INFO - 'USER': 'cltbld', 16:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:06 INFO - 'XPC_FLAGS': '0x0', 16:10:06 INFO - 'XPC_SERVICE_NAME': '0', 16:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:06 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 16:10:06 INFO - Cleaning up... 16:10:06 INFO - Return code: 0 16:10:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:10:06 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')]} 16:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:06 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')]} 16:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:06 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 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10:06 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 16:10:06 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 16:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:06 INFO - 'HOME': '/Users/cltbld', 16:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:06 INFO - 'LOGNAME': 'cltbld', 16:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:06 INFO - 'MOZ_NO_REMOTE': '1', 16:10:06 INFO - 'NO_EM_RESTART': '1', 16:10:06 INFO - 'PAGER': '/bin/cat', 16:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:06 INFO - 'PWD': '/builds/slave/test', 16:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:06 INFO - 'SHELL': '/bin/bash', 16:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:06 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:06 INFO - 'USER': 'cltbld', 16:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:06 INFO - 'XPC_FLAGS': '0x0', 16:10:06 INFO - 'XPC_SERVICE_NAME': '0', 16:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:06 INFO - Downloading/unpacking psutil>=3.1.1 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:10:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:10 INFO - Installing collected packages: psutil 16:10:10 INFO - Running setup.py install for psutil 16:10:10 INFO - building 'psutil._psutil_osx' extension 16:10:10 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 16:10:11 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 16:10:11 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 16:10:11 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 16:10:11 INFO - building 'psutil._psutil_posix' extension 16:10:11 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 16:10:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:10:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:10:11 INFO - ^ 16:10:11 INFO - 1 warning generated. 16:10:11 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 16:10:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:10:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:10:11 INFO - Successfully installed psutil 16:10:11 INFO - Cleaning up... 16:10:12 INFO - Return code: 0 16:10:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:10:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:12 INFO - 'HOME': '/Users/cltbld', 16:10:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:12 INFO - 'LOGNAME': 'cltbld', 16:10:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:12 INFO - 'MOZ_NO_REMOTE': '1', 16:10:12 INFO - 'NO_EM_RESTART': '1', 16:10:12 INFO - 'PAGER': '/bin/cat', 16:10:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:12 INFO - 'PWD': '/builds/slave/test', 16:10:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:12 INFO - 'SHELL': '/bin/bash', 16:10:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:12 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:12 INFO - 'USER': 'cltbld', 16:10:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:12 INFO - 'XPC_FLAGS': '0x0', 16:10:12 INFO - 'XPC_SERVICE_NAME': '0', 16:10:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:15 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:10:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:10:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:10:15 INFO - Installing collected packages: mozsystemmonitor 16:10:15 INFO - Running setup.py install for mozsystemmonitor 16:10:15 INFO - Successfully installed mozsystemmonitor 16:10:15 INFO - Cleaning up... 16:10:15 INFO - Return code: 0 16:10:15 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:15 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 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10:15 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 16:10:15 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 16:10:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:15 INFO - 'HOME': '/Users/cltbld', 16:10:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:15 INFO - 'LOGNAME': 'cltbld', 16:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:15 INFO - 'MOZ_NO_REMOTE': '1', 16:10:15 INFO - 'NO_EM_RESTART': '1', 16:10:15 INFO - 'PAGER': '/bin/cat', 16:10:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:15 INFO - 'PWD': '/builds/slave/test', 16:10:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:15 INFO - 'SHELL': '/bin/bash', 16:10:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:15 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:15 INFO - 'USER': 'cltbld', 16:10:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:15 INFO - 'XPC_FLAGS': '0x0', 16:10:15 INFO - 'XPC_SERVICE_NAME': '0', 16:10:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:15 INFO - Downloading/unpacking jsonschema==2.5.1 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10: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 16:10:18 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:10:18 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:10:18 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 16:10:18 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 16:10:18 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 16:10:18 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 16:10:18 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 16:10:18 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 16:10:18 INFO - Downloading functools32-3.2.3-2.tar.gz 16:10:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:10:18 INFO - warning: no files found matching '*.txt' 16:10:18 INFO - no previously-included directories found matching 'build' 16:10:18 INFO - no previously-included directories found matching 'dist' 16:10:18 INFO - no previously-included directories found matching '.git*' 16:10:18 INFO - Installing collected packages: jsonschema, functools32 16:10:18 INFO - Running setup.py install for functools32 16:10:18 INFO - warning: no files found matching '*.txt' 16:10:18 INFO - no previously-included directories found matching 'build' 16:10:18 INFO - no previously-included directories found matching 'dist' 16:10:18 INFO - no previously-included directories found matching '.git*' 16:10:18 INFO - Successfully installed jsonschema functools32 16:10:18 INFO - Cleaning up... 16:10:19 INFO - Return code: 0 16:10:19 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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', '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 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:10: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 functools32==3.2.3-2 16:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:19 INFO - 'HOME': '/Users/cltbld', 16:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:19 INFO - 'LOGNAME': 'cltbld', 16:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:19 INFO - 'MOZ_NO_REMOTE': '1', 16:10:19 INFO - 'NO_EM_RESTART': '1', 16:10:19 INFO - 'PAGER': '/bin/cat', 16:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:19 INFO - 'PWD': '/builds/slave/test', 16:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:19 INFO - 'SHELL': '/bin/bash', 16:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:19 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:19 INFO - 'USER': 'cltbld', 16:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:19 INFO - 'XPC_FLAGS': '0x0', 16:10:19 INFO - 'XPC_SERVICE_NAME': '0', 16:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:19 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:10:19 INFO - Cleaning up... 16:10:19 INFO - Return code: 0 16:10:19 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:10: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')]} 16:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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')]} 16:10:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10: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', '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 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:10: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 blobuploader==1.2.4 16:10:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:19 INFO - 'HOME': '/Users/cltbld', 16:10:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:19 INFO - 'LOGNAME': 'cltbld', 16:10:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:19 INFO - 'MOZ_NO_REMOTE': '1', 16:10:19 INFO - 'NO_EM_RESTART': '1', 16:10:19 INFO - 'PAGER': '/bin/cat', 16:10:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:19 INFO - 'PWD': '/builds/slave/test', 16:10:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:19 INFO - 'SHELL': '/bin/bash', 16:10:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:19 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:19 INFO - 'USER': 'cltbld', 16:10:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:19 INFO - 'XPC_FLAGS': '0x0', 16:10:19 INFO - 'XPC_SERVICE_NAME': '0', 16:10:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:19 INFO - Downloading/unpacking blobuploader==1.2.4 16:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:10:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:10:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:10:22 INFO - Downloading blobuploader-1.2.4.tar.gz 16:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:10:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:10:22 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 16:10:22 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 16:10:22 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 16:10:22 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 16:10:22 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 16:10:22 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 16:10:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:10:22 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:10:22 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 16:10:22 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 16:10:22 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 16:10:22 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 16:10:22 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 16:10:22 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 16:10:23 INFO - Downloading docopt-0.6.1.tar.gz 16:10:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:10:23 INFO - Installing collected packages: blobuploader, requests, docopt 16:10:23 INFO - Running setup.py install for blobuploader 16:10:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:10:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:10:23 INFO - Running setup.py install for requests 16:10:24 INFO - Running setup.py install for docopt 16:10:24 INFO - Successfully installed blobuploader requests docopt 16:10:24 INFO - Cleaning up... 16:10:24 INFO - Return code: 0 16:10:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:24 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 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10:24 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 16:10:24 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 16:10:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:24 INFO - 'HOME': '/Users/cltbld', 16:10:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:24 INFO - 'LOGNAME': 'cltbld', 16:10:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:24 INFO - 'MOZ_NO_REMOTE': '1', 16:10:24 INFO - 'NO_EM_RESTART': '1', 16:10:24 INFO - 'PAGER': '/bin/cat', 16:10:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:24 INFO - 'PWD': '/builds/slave/test', 16:10:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:24 INFO - 'SHELL': '/bin/bash', 16:10:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:24 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:24 INFO - 'USER': 'cltbld', 16:10:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:24 INFO - 'XPC_FLAGS': '0x0', 16:10:24 INFO - 'XPC_SERVICE_NAME': '0', 16:10:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:24 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-racpJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:24 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-8BMM9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:24 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-90lpBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:24 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TWv3Ih-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-2tWpQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-sg6g7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-f6D0fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-VyTPiX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-jzxW9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-UAclA2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-bXz9e_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-_9Cbqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-5F3fMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:25 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-SHMI_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-6r7Nxc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-D_gOMc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:26 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-l083fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:26 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:10:26 INFO - Running setup.py install for manifestparser 16:10:26 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:10:26 INFO - Running setup.py install for mozcrash 16:10:26 INFO - Running setup.py install for mozdebug 16:10:26 INFO - Running setup.py install for mozdevice 16:10:26 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:10:26 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:10:26 INFO - Running setup.py install for mozfile 16:10:27 INFO - Running setup.py install for mozhttpd 16:10:27 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:10:27 INFO - Running setup.py install for mozinfo 16:10:27 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:10:27 INFO - Running setup.py install for mozInstall 16:10:27 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:10:27 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:10:27 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:10:27 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:10:27 INFO - Running setup.py install for mozleak 16:10:27 INFO - Running setup.py install for mozlog 16:10:27 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:10:27 INFO - Running setup.py install for moznetwork 16:10:27 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:10:27 INFO - Running setup.py install for mozprocess 16:10:28 INFO - Running setup.py install for mozprofile 16:10:28 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:10:28 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:10:28 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:10:28 INFO - Running setup.py install for mozrunner 16:10:28 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:10:28 INFO - Running setup.py install for mozscreenshot 16:10:28 INFO - Running setup.py install for moztest 16:10:28 INFO - Running setup.py install for mozversion 16:10:28 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:10:28 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:10:28 INFO - Cleaning up... 16:10:28 INFO - Return code: 0 16:10:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:28 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')]} 16:10:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:28 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')]} 16:10:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:28 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 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10:28 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 16:10:28 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 16:10:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:28 INFO - 'HOME': '/Users/cltbld', 16:10:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:28 INFO - 'LOGNAME': 'cltbld', 16:10:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:28 INFO - 'MOZ_NO_REMOTE': '1', 16:10:28 INFO - 'NO_EM_RESTART': '1', 16:10:28 INFO - 'PAGER': '/bin/cat', 16:10:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:28 INFO - 'PWD': '/builds/slave/test', 16:10:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:28 INFO - 'SHELL': '/bin/bash', 16:10:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:28 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:28 INFO - 'USER': 'cltbld', 16:10:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:28 INFO - 'XPC_FLAGS': '0x0', 16:10:28 INFO - 'XPC_SERVICE_NAME': '0', 16:10:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:10:29 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-DBMvhZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:10:29 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)) 16:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:10:29 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-0x9ZkT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:10:29 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)) 16:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:10:29 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-jRdmF5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:10:29 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)) 16:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:10:29 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Ua44jJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:10:29 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)) 16:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:10:29 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-MzTQho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:10:29 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)) 16:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:10:29 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-OVjM0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:10:29 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)) 16:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:10:29 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-gdn76m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:10:29 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)) 16:10:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:10:29 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-SpX2qS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:10:30 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)) 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:10:30 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-eat5LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:10:30 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)) 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:10:30 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-Urrnpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:10:30 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)) 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:10:30 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-U4ggvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:10:30 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)) 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:10:30 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-t5Hv8r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:10:30 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:10:30 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-GADWvA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:10:30 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)) 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:10:30 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-7KibAI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:10:30 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)) 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:30 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-V5dR2p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:10:30 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)) 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:10:30 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-L3nK7n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:10:30 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)) 16:10:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:10:30 INFO - Running setup.py (path:/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/pip-TkeWXj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:10:30 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)) 16:10:30 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)) 16:10:30 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)) 16:10:30 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)) 16:10:30 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)) 16:10:30 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)) 16:10:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:10:30 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 16:10:30 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 16:10:30 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 16:10:30 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 16:10:30 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 16:10:30 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 16:10:33 INFO - Downloading blessings-1.6.tar.gz 16:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:10:33 INFO - Installing collected packages: blessings 16:10:33 INFO - Running setup.py install for blessings 16:10:33 INFO - Successfully installed blessings 16:10:33 INFO - Cleaning up... 16:10:33 INFO - Return code: 0 16:10:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:10:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:34 INFO - Reading from file tmpfile_stdout 16:10:34 INFO - Current package versions: 16:10:34 INFO - blessings == 1.6 16:10:34 INFO - blobuploader == 1.2.4 16:10:34 INFO - docopt == 0.6.1 16:10:34 INFO - functools32 == 3.2.3-2 16:10:34 INFO - jsonschema == 2.5.1 16:10:34 INFO - manifestparser == 1.1 16:10:34 INFO - mozInstall == 1.12 16:10:34 INFO - mozcrash == 1.0 16:10:34 INFO - mozdebug == 0.1 16:10:34 INFO - mozdevice == 0.49 16:10:34 INFO - mozfile == 1.2 16:10:34 INFO - mozhttpd == 0.7 16:10:34 INFO - mozinfo == 0.9 16:10:34 INFO - mozleak == 0.1 16:10:34 INFO - mozlog == 3.4 16:10:34 INFO - moznetwork == 0.27 16:10:34 INFO - mozprocess == 0.24 16:10:34 INFO - mozprofile == 0.28 16:10:34 INFO - mozrunner == 6.13 16:10:34 INFO - mozscreenshot == 0.1 16:10:34 INFO - mozsystemmonitor == 0.3 16:10:34 INFO - moztest == 0.8 16:10:34 INFO - mozversion == 1.4 16:10:34 INFO - psutil == 3.1.1 16:10:34 INFO - requests == 1.2.3 16:10:34 INFO - wsgiref == 0.1.2 16:10:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:10:34 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')]} 16:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:34 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')]} 16:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:34 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 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10:34 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 16:10:34 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 16:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:34 INFO - 'HOME': '/Users/cltbld', 16:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:34 INFO - 'LOGNAME': 'cltbld', 16:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:34 INFO - 'MOZ_NO_REMOTE': '1', 16:10:34 INFO - 'NO_EM_RESTART': '1', 16:10:34 INFO - 'PAGER': '/bin/cat', 16:10:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:34 INFO - 'PWD': '/builds/slave/test', 16:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:34 INFO - 'SHELL': '/bin/bash', 16:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:34 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:34 INFO - 'USER': 'cltbld', 16:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:34 INFO - 'XPC_FLAGS': '0x0', 16:10:34 INFO - 'XPC_SERVICE_NAME': '0', 16:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 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)) 16:10:34 INFO - Cleaning up... 16:10:34 INFO - Return code: 0 16:10:34 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:10:34 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')]} 16:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:34 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')]} 16:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:10:34 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 0x101f2cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101f2f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb52572200>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, '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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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 16:10:34 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 16:10:34 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 16:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:34 INFO - 'HOME': '/Users/cltbld', 16:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:34 INFO - 'LOGNAME': 'cltbld', 16:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:34 INFO - 'MOZ_NO_REMOTE': '1', 16:10:34 INFO - 'NO_EM_RESTART': '1', 16:10:34 INFO - 'PAGER': '/bin/cat', 16:10:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:34 INFO - 'PWD': '/builds/slave/test', 16:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:34 INFO - 'SHELL': '/bin/bash', 16:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:34 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:34 INFO - 'USER': 'cltbld', 16:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:34 INFO - 'XPC_FLAGS': '0x0', 16:10:34 INFO - 'XPC_SERVICE_NAME': '0', 16:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:10:34 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:10:34 INFO - Cleaning up... 16:10:34 INFO - Return code: 0 16:10:34 INFO - Running post-action listener: _resource_record_post_action 16:10:34 INFO - Running post-action listener: _start_resource_monitoring 16:10:34 INFO - Starting resource monitoring. 16:10:34 INFO - [mozharness: 2017-03-06 00:10:34.825248Z] Finished create-virtualenv step (success) 16:10:34 INFO - [mozharness: 2017-03-06 00:10:34.826158Z] Running install step. 16:10:34 INFO - Running pre-action listener: _resource_record_pre_action 16:10:34 INFO - Running main action method: install 16:10:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:10:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:10:35 INFO - Reading from file tmpfile_stdout 16:10:35 INFO - Detecting whether we're running mozinstall >=1.0... 16:10:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:10:35 INFO - Reading from file tmpfile_stdout 16:10:35 INFO - Output received: 16:10:35 INFO - Usage: mozinstall [options] installer 16:10:35 INFO - Options: 16:10:35 INFO - -h, --help show this help message and exit 16:10:35 INFO - -d DEST, --destination=DEST 16:10:35 INFO - Directory to install application into. [default: 16:10:35 INFO - "/builds/slave/test"] 16:10:35 INFO - --app=APP Application being installed. [default: firefox] 16:10:35 INFO - mkdir: /builds/slave/test/build/application 16:10:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:10:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 16:10:55 INFO - Reading from file tmpfile_stdout 16:10:55 INFO - Output received: 16:10:55 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 16:10:55 INFO - Running post-action listener: _resource_record_post_action 16:10:55 INFO - [mozharness: 2017-03-06 00:10:55.412526Z] Finished install step (success) 16:10:55 INFO - [mozharness: 2017-03-06 00:10:55.412700Z] Running run-tests step. 16:10:55 INFO - Running pre-action listener: _resource_record_pre_action 16:10:55 INFO - Running main action method: run_tests 16:10:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:10:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:10:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:10:55 INFO - 2017-03-05 16:10:55.427 screenresolution[1637:9857] starting screenresolution argv=screenresolution get 16:10:55 INFO - 2017-03-05 16:10:55.429 screenresolution[1637:9857] Display 0: 1600x1200x32@60 16:10:55 INFO - 2017-03-05 16:10:55.435 screenresolution[1638:9860] starting screenresolution argv=screenresolution list 16:10:55 INFO - Available Modes on Display 0 16:10:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:10:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:10:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:10:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:10:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:10:55 INFO - Intel Iris: 16:10:55 INFO - Chipset Model: Intel Iris 16:10:55 INFO - Type: GPU 16:10:55 INFO - Bus: Built-In 16:10:55 INFO - VRAM (Dynamic, Max): 1536 MB 16:10:55 INFO - Vendor: Intel (0x8086) 16:10:55 INFO - Device ID: 0x0a2e 16:10:55 INFO - Revision ID: 0x0009 16:10:55 INFO - Displays: 16:10:55 INFO - Display: 16:10:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:10:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:10:55 INFO - Display Serial Number: 1600x1200 60 16:10:55 INFO - Main Display: Yes 16:10:55 INFO - Mirror: Off 16:10:55 INFO - Online: Yes 16:10:55 INFO - Rotation: Supported 16:10:55 INFO - Return code: 0 16:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:10:55 INFO - Python 2.7.3 16:10:55 INFO - Return code: 0 16:10:55 INFO - grabbing minidump binary from tooltool 16:10:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:10:55 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101d0ad30>, '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 0x101c31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101cffbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:10:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:10:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:10:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:10:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:10:55 INFO - Return code: 0 16:10:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:10:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:10:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:10:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:10:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:10:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 16:10:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0082 --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 16:10:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.JMTaMtL74Z/Render', 16:10:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:10:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:10:55 INFO - 'HOME': '/Users/cltbld', 16:10:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:10:55 INFO - 'LOGNAME': 'cltbld', 16:10:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:10:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:10:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:10:55 INFO - 'MOZ_NO_REMOTE': '1', 16:10:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:10:55 INFO - 'NO_EM_RESTART': '1', 16:10:55 INFO - 'PAGER': '/bin/cat', 16:10:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:10:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:10:55 INFO - 'PWD': '/builds/slave/test', 16:10:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:10:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:10:55 INFO - 'SHELL': '/bin/bash', 16:10:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.cp5iLHw1ks/Listeners', 16:10:55 INFO - 'TMPDIR': '/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/', 16:10:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:10:55 INFO - 'USER': 'cltbld', 16:10:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:10:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:10:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:10:55 INFO - 'XPC_FLAGS': '0x0', 16:10:55 INFO - 'XPC_SERVICE_NAME': '0', 16:10:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:10:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0082', '--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 16:10:56 INFO - mozversion application_buildid: 20170305141116 16:10:56 INFO - mozversion application_changeset: 69efeba94b307f236a50a9e5fdd2bbd2e946657b 16:10:56 INFO - mozversion application_display_name: FirefoxDeveloperEdition 16:10:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:10:56 INFO - mozversion application_name: Firefox 16:10:56 INFO - mozversion application_remotingname: firefox-dev 16:10:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:10:56 INFO - mozversion application_vendor: Mozilla 16:10:56 INFO - mozversion application_version: 53.0a2 16:10:56 INFO - mozversion platform_buildid: 20170305141116 16:10:56 INFO - mozversion platform_changeset: 69efeba94b307f236a50a9e5fdd2bbd2e946657b 16:10:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 16:10:56 INFO - mozversion platform_version: 53.0a2 16:10:56 INFO - using testdate: 1488759056 16:10:56 INFO - actual date: 1488759056 16:10:56 INFO - starting webserver on 'localhost:49242' 16:10:56 INFO - SUITE-START | Running 2 tests 16:10:56 INFO - TEST-START | dromaeo_css 16:10:56 INFO - operating with platform_type : mac_ 16:10:56 INFO - Initialising browser for dromaeo_css test... 16:10:56 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp088lN3/profile http://localhost:49242/getInfo.html) 16:10:58 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 16:10:58 INFO - PROCESS | 1648 | colorDepth:24 16:10:58 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 16:10:58 INFO - PROCESS | 1648 | __metrics 16:10:58 INFO - PROCESS | 1648 | 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" 16:10:58 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:10:59 INFO - TEST-INFO | 1648: exit 0 16:10:59 INFO - Browser initialized. 16:10:59 INFO - Running cycle 1/1 for dromaeo_css test... 16:10:59 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmp088lN3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:11:11 INFO - PROCESS | 1650 | RSS: Main: 212611072 16:11:11 INFO - PROCESS | 1650 | 16:14:16 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 16:14:17 INFO - PROCESS | 1650 | RSS: Main: 342978560 16:14:17 INFO - PROCESS | 1650 | 16:16:01 INFO - PROCESS | 1650 | ************************* 16:16:01 INFO - PROCESS | 1650 | A coding exception was thrown and uncaught in a Task. 16:16:01 INFO - PROCESS | 1650 | 16:16:01 ERROR - PROCESS | 1650 | Full message: TypeError: NetworkError when attempting to fetch resource. 16:16:01 INFO - PROCESS | 1650 | Full stack: 16:16:01 INFO - PROCESS | 1650 | ************************* 16:17:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 16:17:21 INFO - PROCESS | 1650 | RSS: Main: 352808960 16:17:21 INFO - PROCESS | 1650 | 16:20:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 16:20:24 INFO - PROCESS | 1650 | RSS: Main: 327364608 16:20:24 INFO - PROCESS | 1650 | 16:23:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 16:23:27 INFO - PROCESS | 1650 | RSS: Main: 334548992 16:23:27 INFO - PROCESS | 1650 | 16:26:31 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 16:26:32 INFO - PROCESS | 1650 | RSS: Main: 319864832 16:26:32 INFO - PROCESS | 1650 | 16:29:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 16:29:35 INFO - PROCESS | 1650 | RSS: Main: 392294400 16:29:35 INFO - PROCESS | 1650 | 16:29:35 INFO - PROCESS | 1650 | __start_tp_report 16:29:35 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 16:29:35 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 16:29:35 INFO - PROCESS | 1650 | |i|pagename|runs| 16:29:35 INFO - PROCESS | 1650 | |0;dojo.html;2809.6628404591447;3370.7471939604534;3374.780639258449;3375.1562109472634;3421.0592087176024;5728.4557966993125;5736.856578585537;5764.625299355539;5781.103928891029;5791;5662.292213473316;5739.569532285074;5740.770369185238;5756.827295181151;5767.567432442563;5207.7135757533415;5240.502152295526;5254.264402983586;5262.81580144695;5302.893942121155;5206.140986737184;5208.609354298424;5218.8695282617855;5301.814436494724;5331;5234.973825130869;5259.842204733845;5260.8158714445;5298.470152984709;5335.33308336458;5311.123664595337;5318.893622127574;5326.227696983935;5328.866778330534;5341.813036543741;5158.716270605115;5174.275601415805;5262.842114736526;5263.6841789492755;5313.096773548467;4721.457032441279;5670.0360938640115;5670.064439367499;5729.627574207705;5734.684592347419;6293.968530157365;6324.430801227912;6331.176946996907;6348.206474190726;6359.841003974938;6294.496440284766;6309.179806625155;6346.174997250328;6352.745890164388;6392.680365981682;5706.201131841587;5754.482096611283;5791.507721843691;5847.883042339129;5853.64878107315;6145.924463218918;6279.403456671609;6296.811095667137;6315.5579109462815;6336.841578960563;6083.66539840313;6112.388761123941;6171.13604095427;6183.598066125687;6205.503559715212;6071.908921366183;6267.2792628848265;6304.275008374004;6331.335209802996;6348.269948955837;6122.093225952662;6168.814935551941;6223.719932602953;6237.407446292595;6289.40250676185;6331.303556608769;6366.299707032223;6368.681565921685;6368.84077898047;6385;5024.79900803971;5064.696118232918;5075.390953085654;5082;5083.034223497523;4423.292273236331;4437.090396468716;4448.755318457516;4504.504504504502;4515.412996310524;5811.244538210006;5862.530997520188;5880.029795083763;5943.524518038546;5975.7609695612555;5503.954248692736;6092.634441933498;6279.340669229665;6294.968525157345;6332.651704156224;5863.970680146572;5908.14331921869;5926.7925622603;5953.1070339449425;5965.55258355625;5427.511523962862;5511.834644960658;5521.696306703089;5527.336719593594;5536.058869992111;6282.968585157045;6316.273628532777;6325.905111423424;6407.487401008001;6417.326180750954;6303.369663033844;6348.492120630431;6363.96818015907;6392.744290228525;6399.77600783989;6417.005364168562;6446.903296450463;6456.225252969673;6460.353964603502;6511.023346498063;6049.939500605114;6104.572679912363;6240.344763799917;6267.561270711007;6327.936720632919;5001.399832020181;6194.690265486617;6269.655168965751;6295.96852015737;6298.401651843067;5363.946360536344;6169.537284703575;6176.629402235881;6196.318404975539;6210.068489726577;5990.011648078018;6176.938230617637;6191.659458729813;6213.37866213375;6229.0967809668255;5858.238429004373;5906.852328691817;5913.319968203712;5923.85190370227;6031.487323577369;6195.504359651307;6200.193974783249;6202.41077097675;6213.37866213375;6219.564630475823;6030.909536357046;6034.668093254913;6044.484295997375;6045.21412216409;6084.452399284086 16:29:35 INFO - PROCESS | 1650 | |1;ext.html;459.2972751689911;483.9443464001641;485.28662865587575;505.80273693259625;525.6268049684724;30554.23614409638;38406;40062.79968600156;40218.59781402192;40219;42001.789991050005;42300.36549451761;42490;42498.36252456216;42507.57492425075;7630.542167469969;8340.874886876702;9186.402883812565;9413.48225847578;9447.149756521912;8357.749267521984;11097.889021109766;11335.886641133608;11377.089832813397;11511.194216404854;9618.711438656852;9938.403695778241;11107.111431085534;11279.548818047268;11326.037286830588;8473.406861519696;11279.887201128007;11346.886531134665;11364.26132301406;11375.317480951127;8322.50064996102;10994.230403871732;11273;11278.436078196057;11459.598914037968;40172.799136004134;40697.38953915694;40808;40818;40835.59164408348;3912.100216950089;3914.6868250539887;3957.3272543667645;3974.5826688197612;3975.529054249917;29371.853140734373;29404.852975734986;29515.409691806257;30121.548176777367;30262.394752105054;3029.60615120033;3217.179619197113;3229;3290.720288775457;3331.5502407174963;461974.69012655056;462604;464822;465286;465558;60373;60745;60985.390146098856;60985.69507152436;61022.08466873001;63463.365366345744;63566.68216658887;63613.68193159004;63683;63718.36281637124;14341.6414589634;16132.386761323774;16195.757063644054;16472.01167929928;16518.83481165173;11624.709382265342;11913.88086119145;12909.419076141596;12973.935130324287;12983.285919274342;12100.971417429617;15539.378424862878;15933.840661593467;15936.442224522087;16280.837191627932;7080.575165490087;7461.582299363104;7483.925160748432;7493.66278517468;7515.398768098539;857.9871301930476;861.554972573343;869.891263592051;874.2350443362059;894.7002754077326;29748.40503189924;29795.702042979727;30052.54921176184;30409.695903041127;30466.08601741951;852.4160949749441;966.183574879226;1039.740064983754;1069.9251052426255;1070.4487189097622;15313.540593782205;15406.460773872861;15444.996075255072;15590.766138507932;15683.451079212173;622671;628164;628229;628398;629445;59150.40849591535;59626.70186649039;59680.403195968356;59685;59732.40267597355;1429.106808244847;1443.9711205775825;1446.2190417174818;1449.7607894697258;1462.1665650579068;28094.578581321704;28857.855710721313;29094.49682087309;29568;29645.110646680634;49277.50722492729;49626.503734962185;49749.50250497449;49811.75094124506;49817.750911246665;530086;530442;531073;531273;531750;37385.06537336479;37981.24037519179;38297;38301.42547861728;38365;45848;46216.84457888579;46745.766271168424;46771.76614116908;47074.82312942204;36730.89807305785;37774;37788.62211377851;38728;39104.608953910094;37529.812350939166;38052.61947380491;38729.80635096919;38749;39031;36574;36643.45034824533;37215.88352349434;37504.249915002096;37527.061823454635;31351.372972540878;33174.57482486929;33687.4946875802;33756.3248735019;33841.49237761386;23161.768382316634;23970.40073998164;23994.691572372394;24484.632730509413;25113.372165696004 16:29:35 INFO - PROCESS | 1650 | |2;jquery.html;342.8508598759538;359.9514065601144;363.65816132835147;390.2838291734666;410.40081481037686;14859;15291.770623440643;16091.597710057255;20361.28735494258;21060;20903.37289881306;21972.670409943865;22050.88974555125;22653;22754;5604.747786349603;5661.8584535386535;5803.100519419486;5886.735096920649;6082.300535438415;5835.270591176103;5895.557833162508;5952.166696662471;5963.284405871302;5968.343482216953;4208.452901122865;4414.161309351229;4425.535318791529;5809.419058094178;6623.337666233387;6675;6684.131062961808;6694.8284050291495;6697.564658297195;6713.798586042427;5638.40796716343;5842.5618078644275;5871.911921321183;5880.970595146997;5921.763129474816;25134.86893089797;25637.846296916683;25982.480350393074;26313.605295920577;26398.73601263982;2650.2844232057428;2693.165118813174;2761.5443451830424;2767.33583939855;2772.1683494951635;15106.39574417022;15584.532464025984;15787.368505259776;16235.918820405941;16521.83478165215;1737.2877120380583;1775.0592186141366;1782.1267578886382;1794.3450640516248;1807.6023274879506;107119.92880071177;129374;132095;134713;137386.6261337394;11203.831942520868;11729.941350293195;11778.882211177779;11799.174057816042;11981.023131183258;14317.35571899267;14909.030912990622;14924.92537537327;14940.32768525419;14946.850531494545;8552.871706924401;8890.288776897833;8895.911040889638;8919.375643704878;9037.322200834964;8057.59712014397;8100.878486822702;8806.427582207265;8956.149165829236;8985.640574377083;7200.531965422231;7366.77899663011;7371.852562948819;7378.852422951511;7380.372668323145;1876.2026138890917;1905.64421333652;1921.5100149461798;1922.6539222939725;1927.4506765571746;922.5479515037583;1015.8476228565775;1028.5063169678597;1047.1936608811172;1053.9092039738987;22643.43391415228;23152.76847231506;23202.76797232006;23237.651435228487;23256.534869302857;1060.4485667452882;1064.4411683865878;1081.3457857995957;1102.5755084292446;1119.9104071674246;11639.88360116388;12049;12071.3360765157;12103.636890893287;12252.019838412905;531121;551758;559617;560818;781052;117762.58372108026;128392;131710;156079.21960390126;156982;841.9284360829398;972.7081875437341;979.3438396274513;1050.6637875879799;1055.4247934875511;19155.329563465213;19197.616047679247;19791.60416791685;19831;19976.800231997495;54587.45412545982;55593;57108.85782284248;57719.422805771406;58181.70909145597;84532.57733711292;86090;86221;86894.56552717196;87408.56295718481;7284.453665974967;8222.506649601042;8283.58582070882;8602.010768761673;8790.824183516166;11086;13137.60587182386;13289.269090200132;13718.65703357424;13732.244726540137;10536.315139515908;11103.722406939569;11399.601013964802;11517.193796434169;11866.347350895438;11036.668899933014;11256.155788316073;11271.323720576791;11735.941320293345;11777.764444711229;9928.305018648625;10958.01377875995;11529;11962.820557691815;12102.394880255775;7533.434992375484;7602.1257555381835;7683.270089341504;7749.186335434923;7810.336121429742;11239.831402528805;11309.377984210947;11632.88367116318;11748.295102293549;11823.586174484195 16:29:35 INFO - PROCESS | 1650 | |3;mootools.html;1424.80052792609;1441.5242969819958;1449.6738233897374;1451.151076620177;1462.2542503323305;8045.597720113993;8452.154784521545;8456.238938495535;8472.534010629413;8480.575971201439;7432.479726419153;7652.770416887488;7657.655405506752;7976.2821346078845;8236.876446853303;2265.4562904902828;2301.7698230176934;2301.9884900575476;2307.746147923727;2313.5025969416574;2125.6492678707996;2322.976770232293;2334.1013709721797;2336.9649455258186;2339.4502291961376;1858.7862395824518;2046.3758553641132;2132.115172203534;2132.5628246209567;2318.049599664138;2259.367377134405;2272.715910511186;2277.1346888182384;2283.3378320287097;2284.7715228477186;1974.1215159254139;2208.2823082498094;2218.678291647718;2318.3508617586936;2335.089315167086;8347.624356903892;8429.157084291583;8431.831363372698;8450.704225352145;8452.239298463168;4465.642748580139;5050.570701490377;5170.146925757245;5233.842984710464;5239.580833533309;3286;3474.5656792900886;3482.3905816482015;3542.468629705539;3559.8220088995445;1130.829591372925;1161.3786624156037;1186.0689358853344;1207.4445754952733;1231.87681231877;10919.672409827717;10950.507227174796;10951.83572246409;10954.178436617205;10999.780004399867;4574.519675434031;4695.835645752451;4723.197056500403;4800.231962885921;4804.35141255926;8264.504129752115;9525.857112143323;9636.42181469114;9639.614415423304;9643.27675424346;5275.60432967529;5283.867903302448;5286.524212820787;5292.603054770831;5306.28365170697;4620.976895115503;4701.3653156824075;4724.905501889943;4739.597134243559;4846.951530484721;3260.3805276997296;3808.771473711586;3904.7657140571087;3946.131850992777;3960.7623542587535;1078.4607696151925;1268.1566758105942;1276.2789024201297;1288.5361269942814;1292.4442489729317;772.8917951486796;845.2941793602411;884.0717246890739;894.9194572488507;916.8395530782086;5487.533559647395;5518.91721624176;5687.687177205294;5804.31671834005;5853.707314634251;983.6262220356219;1007.5667462990838;1012.4886932099242;1024.4826362686795;1040.3237895368072;3712.276106159327;3755.3240416724707;3765.134019175605;3841.8847434577006;3865.342891708416;9741.415515069119;9775.804483910424;10017.499125043865;10072.697819065439;10119.949400252952;9738.75653108678;9767.120959113714;10043.69868903934;10045.196384289386;10105.848412273821;7734.1492435832015;7816.6091695416135;7821.217878212247;7961.641726122339;7986.201379861967;5309.177077552986;5418.376886658085;5554;5589.245451864109;5771.384012476513;7582.317591416799;9312.813743725223;9330.393524420891;9333.346665733605;9337.206337461392;9005.385064555883;9232.630694772402;9439.622415103318;9479.099485548863;9513.952430237805;6657.434118099822;6745.831354216184;6787.728490860508;6788.1175447191545;6789.083473730983;7622.733204337822;7693.807654808675;7804.6878124874365;7804.843903121792;7815.8436831261915;6997.755078572225;7145.071140751669;7165.176004759311;7172.677229524788;7185.856282874418;6898.517103802686;6955.652217389009;6991;7064.32888875556;7072.08062951813;6314.431701146918;6428.228612566335;6469.385408386196;6473.77341793035;6476.6114033158165;4774.665773395829;4919.311296418433;4964.032013757283;4972.9254061188385;5018.4981501849525;4903.141950158637;5010;5011.448740638454;5049.57078648319;5178.922316165185 16:29:35 INFO - PROCESS | 1650 | |4;prototype.html;315.2449882531337;319.1255958673236;343.4266457509612;358.9551306086739;369.38681788231526;4754.9524504754945;5029.849104526861;5178.255524571978;5215.478452154792;5329.520343169119;5219.243209734586;5223.738813059342;5302.984865751019;5340.608713466947;5359.946400535993;3157.2264795125225;3491.6682915123024;3985.2029594081155;4176.498820141572;4222.289972561118;3485.5817301923676;3676.981615091921;3897.1815918656976;4204.600562946531;4212.368144778277;3829.7127715421316;3972.8410863565423;4036.132231570212;4101.293146523295;4187.743676896934;3431.6739909708663;3474.114100904253;4012.498437695288;4146.875593732193;4222.662187025031;3699.35261329269;3706.5181526401666;3714.164313029574;3721.7208709346637;3762.8682996095004;4692.803335149549;4881.706347817832;5261.973690131563;5286.392064912546;5290.4974027467715;4176.331786914109;4282.42187304713;4562.51718191589;4646.3495110684535;4670.10860601457;4946.788036930975;5672.971635141798;5747.2241247431475;5763.818417224459;5768.855778605568;3300.9174770630684;3385.5298319222993;3517.7009954153928;3904.316744569689;3922.8038598070266;4974.10466116099;5320.791871373337;5360.946390536123;6018.789342372996;6049.969750151221;3840.711946604016;3863.840847745665;3887.630675085862;3896.9019629394697;3928.6660633846445;3209.6629853865006;3444.5866496020135;3554.9466757998134;3875.457435958968;3939.7045221608496;3602.423612222032;3935.940960885589;4291.7768435995595;4562.5665561771575;4605;4598.908021839545;5593;5655.349634791969;5684.8863022739315;5693.345265294544;1194.5938380950518;1201.5734414282979;1279.6544932868073;1316.1773891317926;1396.8253968253969;947.331618749311;981.6907674082642;982.5234761140841;986.3785814936688;1003.533356988989;4500.504944456107;4634.967578206982;4661.254199328091;5028.547430731179;5089.6691715038405;4797.376341075638;5059.064073146406;5432.891342173134;5624.437556244343;5703.828885133453;4175.561566035583;4354.390385346054;4418.668599854959;5019.372578427697;5088.287639730441;2525.103588226153;2651.297406187362;2884.178009267349;2930.340673348522;2967.302683869289;5725.59920805548;5754.532594188455;5759.1937128802;5859.941400586024;5881.2358191649855;5264.842054738364;5424.783008679688;5636.886167687036;5660.688662123541;5669.34802497718;5660.009498337857;5841.123831425235;5845.678487683133;5845.9707701462075;5869.735861886225;4832.323474713613;4853.538913803183;5407.188921661782;5578.553715702653;5683.9715801420725;4800.927986080282;5044.9243261350375;5307.460836357567;5461.371942226695;5507.504324610644;5199.4540573239265;5491.983982963165;5839.138821977116;5865.882682346414;5943.851403714942;3421.794692318469;3784.924301513899;3868.0273060738664;3877.360235561101;4062.4921884764403;5246.685198888079;5447.509724124848;5615.887682246251;5637.887242255214;5651.632643878134;5131.255967884561;5180.7150606717;5224.634275600672;5599.888002239851;5600;4986.675866068694;5237.004969055867;5411.594130440311;5641.774329026793;5651.547876169814;4641.932355558308;5045.798168073383;5102.183650615883;5473.8357849264585;5525.640833345819;5675.858103547279;5685.289338832646;5701.971490142523;5715.199872017838;5719.685417302088;5241.633085683966;5563.8887222256135;5580.06164544373;5586.497215250647;5612.775488980558 16:29:35 INFO - PROCESS | 1650 | |5;yui.html;694.4097517110459;718.0593422616373;739.5377888819488;803.2449497472376;821.425002498251;14653.70692586149;15306.23468826557;15588.376464941402;16357.83642163578;17265.741013884803;15872.603184920383;16011.91994040031;16292.918535407336;16347.26437310321;16399.180040997962;837.2924878477677;852.1606217875387;857.7298151082421;857.8455877941968;858.4076986879033;666.6566718140161;684.9041134241211;691.3086913086913;843.6077224090797;844.624142256696;862.8662557303596;885.2077390735288;891.8350105230521;892.3619611977435;895.6596493332524;875.5665945357025;878.44218920985;878.5387671472496;879.5426378283257;880.2341962492673;513.8432778002708;530.7531997621086;649.5875119299232;651.0884761334123;651.133991790917;12267.69330766729;12470.43883025266;12475.812862807064;12480.75038499234;14808.777868331983;13753.38109785062;13990.580282591436;14013.229272390014;14239.430422783076;14329.211893345862;10954.835677464844;11311.943440282746;11663.008644265248;11691.298522088702;11715.472803723853;3562.1272788167066;3588.4079126944025;3805.448210009533;3861.7936636396653;3916.74541154824;91294.54352728194;113614.43192784066;117079.3380070799;117972.41013794961;120144.39927800305;10068.295219334575;10403.947980260202;10806.891931080589;10857.077148442313;10960.232783705063;21281.148754049973;21282;22055.889720551295;22219.22232721847;22246.221382251544;7225.385842203472;7394.260573942563;7440.3303702665935;7638.8923606076805;7646.541207527566;4031.173609410064;4093.63157315843;4117.547069822317;4290.678199135077;4360.7819609019425;3598.4962105305276;3700.370936940673;3707.629237076271;3709.4992176056426;3713.164537978933;518.8599078248851;640.8045546108482;646.2600322630561;646.6734299178978;647.1716203259834;655.9114519539896;670.3196255800367;697.1529591546195;700.6251655364356;735.7876158989741;9365.438073715462;9957.302988790716;10025.19798416125;10164;10415.635452759117;632.5256057956533;666.6201660073491;676.2392308652766;705.5413980912448;725.74598890389;4307;4469.754163520973;4624.583787459145;4743.5967942724565;4990.4011518618;86438;96288.51855740676;98732.50633746928;99462;101155;79420.20579794128;85008.724869127;88470;88560;90381.54809225912;70002.29997699958;71011.64494177495;72104;77384;81502.18497814945;10197.286189966631;10680.732981675521;10912.399818009768;10958.12335013213;11009.669709908716;47515.57453276407;47923;48444.273335900696;49411;51102.97794044173;66882.33117668761;68573;68592.3140768606;69816.65091674509;71895;12397.75204495923;12856.807147892601;12945.352732363155;12988.220706757626;13055.086143970211;11514.481848316678;13766.587002389944;13766.724665506834;14523.18460192481;14662.560123196321;12483.56307529232;13387.598372048855;13388.799168012682;13420;13857.792133118213;12413.317267550372;13190.538331158363;13513.256770877697;13664.385102670205;13882.375293112036;12703.36483175856;12777.616671499869;13060.869391306345;13141.73716525645;13511.797323039966;9468.10309668032;10662.520186591777;10890.455477226265;11097.722556936142;11554.42227888619;10550.547471510125;10683.145348372267;10686.198535110054;10691.625793097204;10707.892921071001 16:29:35 INFO - PROCESS | 1650 | __end_tp_report 16:29:35 INFO - PROCESS | 1650 | __start_cc_report 16:29:35 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1416 16:29:35 INFO - PROCESS | 1650 | __end_cc_report 16:29:35 INFO - PROCESS | 1650 | __startTimestamp1488760175530__endTimestamp 16:29:35 INFO - PROCESS | 1650 | 16:29:35 INFO - PROCESS | 1650 | ------- Summary: start ------- 16:29:35 INFO - PROCESS | 1650 | Number of tests: 6 16:29:35 INFO - PROCESS | 1650 | 16:29:35 INFO - PROCESS | 1650 | [#0] dojo.html Cycles:165 Average:5789.04 Median:5990.01 stddev:664.05 (11.1%) stddev-sans-first:623.61 16:29:35 INFO - PROCESS | 1650 | Values: 2809.7 3370.7 3374.8 3375.2 3421.1 5728.5 5736.9 5764.6 5781.1 5791.0 5662.3 5739.6 5740.8 5756.8 5767.6 5207.7 5240.5 5254.3 5262.8 5302.9 5206.1 5208.6 5218.9 5301.8 5331.0 5235.0 5259.8 5260.8 5298.5 5335.3 5311.1 5318.9 5326.2 5328.9 5341.8 5158.7 5174.3 5262.8 5263.7 5313.1 4721.5 5670.0 5670.1 5729.6 5734.7 6294.0 6324.4 6331.2 6348.2 6359.8 6294.5 6309.2 6346.2 6352.7 6392.7 5706.2 5754.5 5791.5 5847.9 5853.6 6145.9 6279.4 6296.8 6315.6 6336.8 6083.7 6112.4 6171.1 6183.6 6205.5 6071.9 6267.3 6304.3 6331.3 6348.3 6122.1 6168.8 6223.7 6237.4 6289.4 6331.3 6366.3 6368.7 6368.8 6385.0 5024.8 5064.7 5075.4 5082.0 5083.0 4423.3 4437.1 4448.8 4504.5 4515.4 5811.2 5862.5 5880.0 5943.5 5975.8 5504.0 6092.6 6279.3 6295.0 6332.7 5864.0 5908.1 5926.8 5953.1 5965.6 5427.5 5511.8 5521.7 5527.3 5536.1 6283.0 6316.3 6325.9 6407.5 6417.3 6303.4 6348.5 6364.0 6392.7 6399.8 6417.0 6446.9 6456.2 6460.4 6511.0 6049.9 6104.6 6240.3 6267.6 6327.9 5001.4 6194.7 6269.7 6296.0 6298.4 5363.9 6169.5 6176.6 6196.3 6210.1 5990.0 6176.9 6191.7 6213.4 6229.1 5858.2 5906.9 5913.3 5923.9 6031.5 6195.5 6200.2 6202.4 6213.4 6219.6 6030.9 6034.7 6044.5 6045.2 6084.5 16:29:35 INFO - PROCESS | 1650 | 16:29:35 INFO - PROCESS | 1650 | [#1] ext.html Cycles:180 Average:68064.68 Median:38728.90 stddev:145361.87 (375.3%) stddev-sans-first:145681.02 16:29:35 INFO - PROCESS | 1650 | Values: 459.3 483.9 485.3 505.8 525.6 30554.2 38406.0 40062.8 40218.6 40219.0 42001.8 42300.4 42490.0 42498.4 42507.6 7630.5 8340.9 9186.4 9413.5 9447.1 8357.7 11097.9 11335.9 11377.1 11511.2 9618.7 9938.4 11107.1 11279.5 11326.0 8473.4 11279.9 11346.9 11364.3 11375.3 8322.5 10994.2 11273.0 11278.4 11459.6 40172.8 40697.4 40808.0 40818.0 40835.6 3912.1 3914.7 3957.3 3974.6 3975.5 29371.9 29404.9 29515.4 30121.5 30262.4 3029.6 3217.2 3229.0 3290.7 3331.6 461974.7 462604.0 464822.0 465286.0 465558.0 60373.0 60745.0 60985.4 60985.7 61022.1 63463.4 63566.7 63613.7 63683.0 63718.4 14341.6 16132.4 16195.8 16472.0 16518.8 11624.7 11913.9 12909.4 12973.9 12983.3 12101.0 15539.4 15933.8 15936.4 16280.8 7080.6 7461.6 7483.9 7493.7 7515.4 858.0 861.6 869.9 874.2 894.7 29748.4 29795.7 30052.5 30409.7 30466.1 852.4 966.2 1039.7 1069.9 1070.4 15313.5 15406.5 15445.0 15590.8 15683.5 622671.0 628164.0 628229.0 628398.0 629445.0 59150.4 59626.7 59680.4 59685.0 59732.4 1429.1 1444.0 1446.2 1449.8 1462.2 28094.6 28857.9 29094.5 29568.0 29645.1 49277.5 49626.5 49749.5 49811.8 49817.8 530086.0 530442.0 531073.0 531273.0 531750.0 37385.1 37981.2 38297.0 38301.4 38365.0 45848.0 46216.8 46745.8 46771.8 47074.8 36730.9 37774.0 37788.6 38728.0 39104.6 37529.8 38052.6 38729.8 38749.0 39031.0 36574.0 36643.5 37215.9 37504.2 37527.1 31351.4 33174.6 33687.5 33756.3 33841.5 23161.8 23970.4 23994.7 24484.6 25113.4 16:29:35 INFO - PROCESS | 1650 | 16:29:35 INFO - PROCESS | 1650 | [#2] jquery.html Cycles:180 Average:36307.70 Median:22953.38 stddev:101424.91 (441.9%) stddev-sans-first:101673.48 16:29:35 INFO - PROCESS | 1650 | Values: 342.9 360.0 363.7 390.3 410.4 14859.0 15291.8 16091.6 20361.3 21060.0 20903.4 21972.7 22050.9 22653.0 22754.0 5604.7 5661.9 5803.1 5886.7 6082.3 5835.3 5895.6 5952.2 5963.3 5968.3 4208.5 4414.2 4425.5 5809.4 6623.3 6675.0 6684.1 6694.8 6697.6 6713.8 5638.4 5842.6 5871.9 5881.0 5921.8 25134.9 25637.8 25982.5 26313.6 26398.7 2650.3 2693.2 2761.5 2767.3 2772.2 15106.4 15584.5 15787.4 16235.9 16521.8 1737.3 1775.1 1782.1 1794.3 1807.6 107119.9 129374.0 132095.0 134713.0 137386.6 11203.8 11729.9 11778.9 11799.2 11981.0 14317.4 14909.0 14924.9 14940.3 14946.9 8552.9 8890.3 8895.9 8919.4 9037.3 8057.6 8100.9 8806.4 8956.1 8985.6 7200.5 7366.8 7371.9 7378.9 7380.4 1876.2 1905.6 1921.5 1922.7 1927.5 922.5 1015.8 1028.5 1047.2 1053.9 22643.4 23152.8 23202.8 23237.7 23256.5 1060.4 1064.4 1081.3 1102.6 1119.9 11639.9 12049.0 12071.3 12103.6 12252.0 531121.0 551758.0 559617.0 560818.0 781052.0 117762.6 128392.0 131710.0 156079.2 156982.0 841.9 972.7 979.3 1050.7 1055.4 19155.3 19197.6 19791.6 19831.0 19976.8 54587.5 55593.0 57108.9 57719.4 58181.7 84532.6 86090.0 86221.0 86894.6 87408.6 7284.5 8222.5 8283.6 8602.0 8790.8 11086.0 13137.6 13289.3 13718.7 13732.2 10536.3 11103.7 11399.6 11517.2 11866.3 11036.7 11256.2 11271.3 11735.9 11777.8 9928.3 10958.0 11529.0 11962.8 12102.4 7533.4 7602.1 7683.3 7749.2 7810.3 11239.8 11309.4 11632.9 11748.3 11823.6 16:29:35 INFO - PROCESS | 1650 | 16:29:35 INFO - PROCESS | 1650 | [#3] mootools.html Cycles:180 Average:5413.88 Median:5110.36 stddev:2952.94 (57.8%) stddev-sans-first:2946.01 16:29:35 INFO - PROCESS | 1650 | Values: 1424.8 1441.5 1449.7 1451.2 1462.3 8045.6 8452.2 8456.2 8472.5 8480.6 7432.5 7652.8 7657.7 7976.3 8236.9 2265.5 2301.8 2302.0 2307.7 2313.5 2125.6 2323.0 2334.1 2337.0 2339.5 1858.8 2046.4 2132.1 2132.6 2318.0 2259.4 2272.7 2277.1 2283.3 2284.8 1974.1 2208.3 2218.7 2318.4 2335.1 8347.6 8429.2 8431.8 8450.7 8452.2 4465.6 5050.6 5170.1 5233.8 5239.6 3286.0 3474.6 3482.4 3542.5 3559.8 1130.8 1161.4 1186.1 1207.4 1231.9 10919.7 10950.5 10951.8 10954.2 10999.8 4574.5 4695.8 4723.2 4800.2 4804.4 8264.5 9525.9 9636.4 9639.6 9643.3 5275.6 5283.9 5286.5 5292.6 5306.3 4621.0 4701.4 4724.9 4739.6 4847.0 3260.4 3808.8 3904.8 3946.1 3960.8 1078.5 1268.2 1276.3 1288.5 1292.4 772.9 845.3 884.1 894.9 916.8 5487.5 5518.9 5687.7 5804.3 5853.7 983.6 1007.6 1012.5 1024.5 1040.3 3712.3 3755.3 3765.1 3841.9 3865.3 9741.4 9775.8 10017.5 10072.7 10119.9 9738.8 9767.1 10043.7 10045.2 10105.8 7734.1 7816.6 7821.2 7961.6 7986.2 5309.2 5418.4 5554.0 5589.2 5771.4 7582.3 9312.8 9330.4 9333.3 9337.2 9005.4 9232.6 9439.6 9479.1 9514.0 6657.4 6745.8 6787.7 6788.1 6789.1 7622.7 7693.8 7804.7 7804.8 7815.8 6997.8 7145.1 7165.2 7172.7 7185.9 6898.5 6955.7 6991.0 7064.3 7072.1 6314.4 6428.2 6469.4 6473.8 6476.6 4774.7 4919.3 4964.0 4972.9 5018.5 4903.1 5010.0 5011.4 5049.6 5178.9 16:29:35 INFO - PROCESS | 1650 | 16:29:35 INFO - PROCESS | 1650 | [#4] prototype.html Cycles:180 Average:4470.94 Median:5029.20 stddev:1372.98 (27.3%) stddev-sans-first:1340.94 16:29:35 INFO - PROCESS | 1650 | Values: 315.2 319.1 343.4 359.0 369.4 4755.0 5029.8 5178.3 5215.5 5329.5 5219.2 5223.7 5303.0 5340.6 5359.9 3157.2 3491.7 3985.2 4176.5 4222.3 3485.6 3677.0 3897.2 4204.6 4212.4 3829.7 3972.8 4036.1 4101.3 4187.7 3431.7 3474.1 4012.5 4146.9 4222.7 3699.4 3706.5 3714.2 3721.7 3762.9 4692.8 4881.7 5262.0 5286.4 5290.5 4176.3 4282.4 4562.5 4646.3 4670.1 4946.8 5673.0 5747.2 5763.8 5768.9 3300.9 3385.5 3517.7 3904.3 3922.8 4974.1 5320.8 5360.9 6018.8 6050.0 3840.7 3863.8 3887.6 3896.9 3928.7 3209.7 3444.6 3554.9 3875.5 3939.7 3602.4 3935.9 4291.8 4562.6 4605.0 4598.9 5593.0 5655.3 5684.9 5693.3 1194.6 1201.6 1279.7 1316.2 1396.8 947.3 981.7 982.5 986.4 1003.5 4500.5 4635.0 4661.3 5028.5 5089.7 4797.4 5059.1 5432.9 5624.4 5703.8 4175.6 4354.4 4418.7 5019.4 5088.3 2525.1 2651.3 2884.2 2930.3 2967.3 5725.6 5754.5 5759.2 5859.9 5881.2 5264.8 5424.8 5636.9 5660.7 5669.3 5660.0 5841.1 5845.7 5846.0 5869.7 4832.3 4853.5 5407.2 5578.6 5684.0 4800.9 5044.9 5307.5 5461.4 5507.5 5199.5 5492.0 5839.1 5865.9 5943.9 3421.8 3784.9 3868.0 3877.4 4062.5 5246.7 5447.5 5615.9 5637.9 5651.6 5131.3 5180.7 5224.6 5599.9 5600.0 4986.7 5237.0 5411.6 5641.8 5651.5 4641.9 5045.8 5102.2 5473.8 5525.6 5675.9 5685.3 5702.0 5715.2 5719.7 5241.6 5563.9 5580.1 5586.5 5612.8 16:29:35 INFO - PROCESS | 1650 | 16:29:35 INFO - PROCESS | 1650 | [#5] yui.html Cycles:180 Average:20245.94 Median:3889.27 stddev:29179.67 (750.3%) stddev-sans-first:29224.60 16:29:35 INFO - PROCESS | 1650 | Values: 694.4 718.1 739.5 803.2 821.4 14653.7 15306.2 15588.4 16357.8 17265.7 15872.6 16011.9 16292.9 16347.3 16399.2 837.3 852.2 857.7 857.8 858.4 666.7 684.9 691.3 843.6 844.6 862.9 885.2 891.8 892.4 895.7 875.6 878.4 878.5 879.5 880.2 513.8 530.8 649.6 651.1 651.1 12267.7 12470.4 12475.8 12480.8 14808.8 13753.4 13990.6 14013.2 14239.4 14329.2 10954.8 11311.9 11663.0 11691.3 11715.5 3562.1 3588.4 3805.4 3861.8 3916.7 91294.5 113614.4 117079.3 117972.4 120144.4 10068.3 10403.9 10806.9 10857.1 10960.2 21281.1 21282.0 22055.9 22219.2 22246.2 7225.4 7394.3 7440.3 7638.9 7646.5 4031.2 4093.6 4117.5 4290.7 4360.8 3598.5 3700.4 3707.6 3709.5 3713.2 518.9 640.8 646.3 646.7 647.2 655.9 670.3 697.2 700.6 735.8 9365.4 9957.3 10025.2 10164.0 10415.6 632.5 666.6 676.2 705.5 725.7 4307.0 4469.8 4624.6 4743.6 4990.4 86438.0 96288.5 98732.5 99462.0 101155.0 79420.2 85008.7 88470.0 88560.0 90381.5 70002.3 71011.6 72104.0 77384.0 81502.2 10197.3 10680.7 10912.4 10958.1 11009.7 47515.6 47923.0 48444.3 49411.0 51103.0 66882.3 68573.0 68592.3 69816.7 71895.0 12397.8 12856.8 12945.4 12988.2 13055.1 11514.5 13766.6 13766.7 14523.2 14662.6 12483.6 13387.6 13388.8 13420.0 13857.8 12413.3 13190.5 13513.3 13664.4 13882.4 12703.4 12777.6 13060.9 13141.7 13511.8 9468.1 10662.5 10890.5 11097.7 11554.4 10550.5 10683.1 10686.2 10691.6 10707.9 16:29:35 INFO - PROCESS | 1650 | -------- Summary: end -------- 16:29:35 INFO - PROCESS | 1650 | 16:29:36 INFO - TEST-INFO | 1650: exit 0 16:29:36 INFO - TEST-OK | dromaeo_css | took 1120144ms 16:29:36 INFO - TEST-START | kraken 16:29:36 INFO - operating with platform_type : mac_ 16:29:36 INFO - Initialising browser for kraken test... 16:29:36 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpQDl4oS/profile http://localhost:49242/getInfo.html) 16:29:38 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 16:29:38 INFO - PROCESS | 1657 | colorDepth:24 16:29:38 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 16:29:38 INFO - PROCESS | 1657 | __metrics 16:29:38 INFO - PROCESS | 1657 | 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" 16:29:38 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:29:39 INFO - TEST-INFO | 1657: exit 0 16:29:39 INFO - Browser initialized. 16:29:39 INFO - Running cycle 1/1 for kraken test... 16:29:39 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/T/tmpQDl4oS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:29:51 INFO - PROCESS | 1658 | RSS: Main: 212873216 16:29:51 INFO - PROCESS | 1658 | 16:29:54 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 16:29:55 INFO - PROCESS | 1658 | RSS: Main: 265474048 16:29:55 INFO - PROCESS | 1658 | 16:29:57 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 16:29:58 INFO - PROCESS | 1658 | RSS: Main: 274817024 16:29:58 INFO - PROCESS | 1658 | 16:30:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 16:30:02 INFO - PROCESS | 1658 | RSS: Main: 372113408 16:30:02 INFO - PROCESS | 1658 | 16:30:04 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 16:30:05 INFO - PROCESS | 1658 | RSS: Main: 276885504 16:30:05 INFO - PROCESS | 1658 | 16:30:07 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:30:07 INFO - PROCESS | 1658 | RSS: Main: 278405120 16:30:07 INFO - PROCESS | 1658 | 16:30:10 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 16:30:11 INFO - PROCESS | 1658 | RSS: Main: 318504960 16:30:11 INFO - PROCESS | 1658 | 16:30:14 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 16:30:14 INFO - PROCESS | 1658 | RSS: Main: 318930944 16:30:14 INFO - PROCESS | 1658 | 16:30:17 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 16:30:18 INFO - PROCESS | 1658 | RSS: Main: 315187200 16:30:18 INFO - PROCESS | 1658 | 16:30:19 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:30:20 INFO - PROCESS | 1658 | RSS: Main: 295104512 16:30:20 INFO - PROCESS | 1658 | 16:30:22 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:30:23 INFO - PROCESS | 1658 | RSS: Main: 298115072 16:30:23 INFO - PROCESS | 1658 | 16:30:25 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:30:26 INFO - PROCESS | 1658 | RSS: Main: 304451584 16:30:26 INFO - PROCESS | 1658 | 16:30:28 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:30:29 INFO - PROCESS | 1658 | RSS: Main: 307982336 16:30:29 INFO - PROCESS | 1658 | 16:30:32 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:30:33 INFO - PROCESS | 1658 | RSS: Main: 309477376 16:30:33 INFO - PROCESS | 1658 | 16:30:34 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 16:30:35 INFO - PROCESS | 1658 | RSS: Main: 353939456 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | __start_tp_report 16:30:35 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 16:30:35 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 16:30:35 INFO - PROCESS | 1658 | |i|pagename|runs| 16:30:35 INFO - PROCESS | 1658 | |0;ai-astar;114;113;113;114;113;113;111;113;113;114 16:30:35 INFO - PROCESS | 1658 | |1;audio-beat-detection;147;110;109;144;112;110;110;112;132;111 16:30:35 INFO - PROCESS | 1658 | |2;audio-dft;185;185;205;265;201;185;185;183;182;185 16:30:35 INFO - PROCESS | 1658 | |3;audio-fft;84;74;82;113;61;59;59;58;73;61 16:30:35 INFO - PROCESS | 1658 | |4;audio-oscillator;88;69;87;70;67;69;83;68;70;82 16:30:35 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;90;88;92;87;134;130;92;89;91;87 16:30:35 INFO - PROCESS | 1658 | |6;imaging-darkroom;98;100;98;98;98;98;98;99;98;99 16:30:35 INFO - PROCESS | 1658 | |7;imaging-desaturate;85;86;87;87;88;87;85;86;84;85 16:30:35 INFO - PROCESS | 1658 | |8;json-parse-financial;58;56;56;57;56;58;57;57;57;57 16:30:35 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;64;75;64;76;71;68;68;68;69;71 16:30:35 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;87;86;82;86;85;86;82;87;87;121 16:30:35 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;136;138;137;136;133;137;140;138;161;138 16:30:35 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;166;168;167;165;167;167;165;176;189;205 16:30:35 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;67;66;66;66;65;66;65;65;64;65 16:30:35 INFO - PROCESS | 1658 | __end_tp_report 16:30:35 INFO - PROCESS | 1658 | __start_cc_report 16:30:35 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2009 16:30:35 INFO - PROCESS | 1658 | __end_cc_report 16:30:35 INFO - PROCESS | 1658 | __startTimestamp1488760235095__endTimestamp 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | ------- Summary: start ------- 16:30:35 INFO - PROCESS | 1658 | Number of tests: 14 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:0.88 (0.8%) stddev-sans-first:0.87 16:30:35 INFO - PROCESS | 1658 | Values: 114.0 113.0 113.0 114.0 113.0 113.0 111.0 113.0 113.0 114.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:119.70 Median:112.00 stddev:15.20 (13.6%) stddev-sans-first:12.50 16:30:35 INFO - PROCESS | 1658 | Values: 147.0 110.0 109.0 144.0 112.0 110.0 110.0 112.0 132.0 111.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:196.10 Median:185.00 stddev:25.47 (13.8%) stddev-sans-first:26.69 16:30:35 INFO - PROCESS | 1658 | Values: 185.0 185.0 205.0 265.0 201.0 185.0 185.0 183.0 182.0 185.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:72.40 Median:67.00 stddev:17.33 (25.9%) stddev-sans-first:17.87 16:30:35 INFO - PROCESS | 1658 | Values: 84.0 74.0 82.0 113.0 61.0 59.0 59.0 58.0 73.0 61.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:75.30 Median:76.00 stddev:8.56 (11.3%) stddev-sans-first:7.75 16:30:35 INFO - PROCESS | 1658 | Values: 88.0 69.0 87.0 70.0 67.0 69.0 83.0 68.0 70.0 82.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:98.00 Median:89.50 stddev:18.04 (20.2%) stddev-sans-first:18.90 16:30:35 INFO - PROCESS | 1658 | Values: 90.0 88.0 92.0 87.0 134.0 130.0 92.0 89.0 91.0 87.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:98.40 Median:98.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 16:30:35 INFO - PROCESS | 1658 | Values: 98.0 100.0 98.0 98.0 98.0 98.0 98.0 99.0 98.0 99.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:86.00 Median:86.50 stddev:1.25 (1.4%) stddev-sans-first:1.27 16:30:35 INFO - PROCESS | 1658 | Values: 85.0 86.0 87.0 87.0 88.0 87.0 85.0 86.0 84.0 85.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:56.90 Median:57.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 16:30:35 INFO - PROCESS | 1658 | Values: 58.0 56.0 56.0 57.0 56.0 58.0 57.0 57.0 57.0 57.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:70.00 stddev:4.01 (5.7%) stddev-sans-first:3.74 16:30:35 INFO - PROCESS | 1658 | Values: 64.0 75.0 64.0 76.0 71.0 68.0 68.0 68.0 69.0 71.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:88.90 Median:86.00 stddev:11.44 (13.3%) stddev-sans-first:12.11 16:30:35 INFO - PROCESS | 1658 | Values: 87.0 86.0 82.0 86.0 85.0 86.0 82.0 87.0 87.0 121.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:138.00 stddev:7.81 (5.7%) stddev-sans-first:8.18 16:30:35 INFO - PROCESS | 1658 | Values: 136.0 138.0 137.0 136.0 133.0 137.0 140.0 138.0 161.0 138.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.50 Median:167.50 stddev:13.32 (8.0%) stddev-sans-first:13.85 16:30:35 INFO - PROCESS | 1658 | Values: 166.0 168.0 167.0 165.0 167.0 167.0 165.0 176.0 189.0 205.0 16:30:35 INFO - PROCESS | 1658 | 16:30:35 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.50 Median:66.00 stddev:0.85 (1.3%) stddev-sans-first:0.71 16:30:35 INFO - PROCESS | 1658 | Values: 67.0 66.0 66.0 66.0 65.0 66.0 65.0 65.0 64.0 65.0 16:30:35 INFO - PROCESS | 1658 | -------- Summary: end -------- 16:30:35 INFO - PROCESS | 1658 | 16:30:36 INFO - TEST-INFO | 1658: exit 0 16:30:36 INFO - TEST-OK | kraken | took 60020ms 16:30:36 INFO - SUITE-END | took 1180s 16:30:36 INFO - Completed test suite (00:19:40) 16:30:36 INFO - javascript benchmark 16:30:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2809.6628404591447, 3370.7471939604534, 3374.780639258449, 3375.1562109472634, 3421.0592087176024, 5728.4557966993125, 5736.856578585537, 5764.625299355539, 5781.103928891029, 5791.0, 5662.292213473316, 5739.569532285074, 5740.770369185238, 5756.827295181151, 5767.567432442563, 5207.7135757533415, 5240.502152295526, 5254.264402983586, 5262.81580144695, 5302.893942121155, 5206.140986737184, 5208.609354298424, 5218.8695282617855, 5301.814436494724, 5331.0, 5234.973825130869, 5259.842204733845, 5260.8158714445, 5298.470152984709, 5335.33308336458, 5311.123664595337, 5318.893622127574, 5326.227696983935, 5328.866778330534, 5341.813036543741, 5158.716270605115, 5174.275601415805, 5262.842114736526, 5263.6841789492755, 5313.096773548467, 4721.457032441279, 5670.0360938640115, 5670.064439367499, 5729.627574207705, 5734.684592347419, 6293.968530157365, 6324.430801227912, 6331.176946996907, 6348.206474190726, 6359.841003974938, 6294.496440284766, 6309.179806625155, 6346.174997250328, 6352.745890164388, 6392.680365981682, 5706.201131841587, 5754.482096611283, 5791.507721843691, 5847.883042339129, 5853.64878107315, 6145.924463218918, 6279.403456671609, 6296.811095667137, 6315.5579109462815, 6336.841578960563, 6083.66539840313, 6112.388761123941, 6171.13604095427, 6183.598066125687, 6205.503559715212, 6071.908921366183, 6267.2792628848265, 6304.275008374004, 6331.335209802996, 6348.269948955837, 6122.093225952662, 6168.814935551941, 6223.719932602953, 6237.407446292595, 6289.40250676185, 6331.303556608769, 6366.299707032223, 6368.681565921685, 6368.84077898047, 6385.0, 5024.79900803971, 5064.696118232918, 5075.390953085654, 5082.0, 5083.034223497523, 4423.292273236331, 4437.090396468716, 4448.755318457516, 4504.504504504502, 4515.412996310524, 5811.244538210006, 5862.530997520188, 5880.029795083763, 5943.524518038546, 5975.7609695612555, 5503.954248692736, 6092.634441933498, 6279.340669229665, 6294.968525157345, 6332.651704156224, 5863.970680146572, 5908.14331921869, 5926.7925622603, 5953.1070339449425, 5965.55258355625, 5427.511523962862, 5511.834644960658, 5521.696306703089, 5527.336719593594, 5536.058869992111, 6282.968585157045, 6316.273628532777, 6325.905111423424, 6407.487401008001, 6417.326180750954, 6303.369663033844, 6348.492120630431, 6363.96818015907, 6392.744290228525, 6399.77600783989, 6417.005364168562, 6446.903296450463, 6456.225252969673, 6460.353964603502, 6511.023346498063, 6049.939500605114, 6104.572679912363, 6240.344763799917, 6267.561270711007, 6327.936720632919, 5001.399832020181, 6194.690265486617, 6269.655168965751, 6295.96852015737, 6298.401651843067, 5363.946360536344, 6169.537284703575, 6176.629402235881, 6196.318404975539, 6210.068489726577, 5990.011648078018, 6176.938230617637, 6191.659458729813, 6213.37866213375, 6229.0967809668255, 5858.238429004373, 5906.852328691817, 5913.319968203712, 5923.85190370227, 6031.487323577369, 6195.504359651307, 6200.193974783249, 6202.41077097675, 6213.37866213375, 6219.564630475823, 6030.909536357046, 6034.668093254913, 6044.484295997375, 6045.21412216409, 6084.452399284086], "value": 5745.336842463343, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [459.2972751689911, 483.9443464001641, 485.28662865587575, 505.80273693259625, 525.6268049684724, 30554.23614409638, 38406.0, 40062.79968600156, 40218.59781402192, 40219.0, 42001.789991050005, 42300.36549451761, 42490.0, 42498.36252456216, 42507.57492425075, 7630.542167469969, 8340.874886876702, 9186.402883812565, 9413.48225847578, 9447.149756521912, 8357.749267521984, 11097.889021109766, 11335.886641133608, 11377.089832813397, 11511.194216404854, 9618.711438656852, 9938.403695778241, 11107.111431085534, 11279.548818047268, 11326.037286830588, 8473.406861519696, 11279.887201128007, 11346.886531134665, 11364.26132301406, 11375.317480951127, 8322.50064996102, 10994.230403871732, 11273.0, 11278.436078196057, 11459.598914037968, 40172.799136004134, 40697.38953915694, 40808.0, 40818.0, 40835.59164408348, 3912.100216950089, 3914.6868250539887, 3957.3272543667645, 3974.5826688197612, 3975.529054249917, 29371.853140734373, 29404.852975734986, 29515.409691806257, 30121.548176777367, 30262.394752105054, 3029.60615120033, 3217.179619197113, 3229.0, 3290.720288775457, 3331.5502407174963, 461974.69012655056, 462604.0, 464822.0, 465286.0, 465558.0, 60373.0, 60745.0, 60985.390146098856, 60985.69507152436, 61022.08466873001, 63463.365366345744, 63566.68216658887, 63613.68193159004, 63683.0, 63718.36281637124, 14341.6414589634, 16132.386761323774, 16195.757063644054, 16472.01167929928, 16518.83481165173, 11624.709382265342, 11913.88086119145, 12909.419076141596, 12973.935130324287, 12983.285919274342, 12100.971417429617, 15539.378424862878, 15933.840661593467, 15936.442224522087, 16280.837191627932, 7080.575165490087, 7461.582299363104, 7483.925160748432, 7493.66278517468, 7515.398768098539, 857.9871301930476, 861.554972573343, 869.891263592051, 874.2350443362059, 894.7002754077326, 29748.40503189924, 29795.702042979727, 30052.54921176184, 30409.695903041127, 30466.08601741951, 852.4160949749441, 966.183574879226, 1039.740064983754, 1069.9251052426255, 1070.4487189097622, 15313.540593782205, 15406.460773872861, 15444.996075255072, 15590.766138507932, 15683.451079212173, 622671.0, 628164.0, 628229.0, 628398.0, 629445.0, 59150.40849591535, 59626.70186649039, 59680.403195968356, 59685.0, 59732.40267597355, 1429.106808244847, 1443.9711205775825, 1446.2190417174818, 1449.7607894697258, 1462.1665650579068, 28094.578581321704, 28857.855710721313, 29094.49682087309, 29568.0, 29645.110646680634, 49277.50722492729, 49626.503734962185, 49749.50250497449, 49811.75094124506, 49817.750911246665, 530086.0, 530442.0, 531073.0, 531273.0, 531750.0, 37385.06537336479, 37981.24037519179, 38297.0, 38301.42547861728, 38365.0, 45848.0, 46216.84457888579, 46745.766271168424, 46771.76614116908, 47074.82312942204, 36730.89807305785, 37774.0, 37788.62211377851, 38728.0, 39104.608953910094, 37529.812350939166, 38052.61947380491, 38729.80635096919, 38749.0, 39031.0, 36574.0, 36643.45034824533, 37215.88352349434, 37504.249915002096, 37527.061823454635, 31351.372972540878, 33174.57482486929, 33687.4946875802, 33756.3248735019, 33841.49237761386, 23161.768382316634, 23970.40073998164, 23994.691572372394, 24484.632730509413, 25113.372165696004], "value": 20034.054714570433, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.8508598759538, 359.9514065601144, 363.65816132835147, 390.2838291734666, 410.40081481037686, 14859.0, 15291.770623440643, 16091.597710057255, 20361.28735494258, 21060.0, 20903.37289881306, 21972.670409943865, 22050.88974555125, 22653.0, 22754.0, 5604.747786349603, 5661.8584535386535, 5803.100519419486, 5886.735096920649, 6082.300535438415, 5835.270591176103, 5895.557833162508, 5952.166696662471, 5963.284405871302, 5968.343482216953, 4208.452901122865, 4414.161309351229, 4425.535318791529, 5809.419058094178, 6623.337666233387, 6675.0, 6684.131062961808, 6694.8284050291495, 6697.564658297195, 6713.798586042427, 5638.40796716343, 5842.5618078644275, 5871.911921321183, 5880.970595146997, 5921.763129474816, 25134.86893089797, 25637.846296916683, 25982.480350393074, 26313.605295920577, 26398.73601263982, 2650.2844232057428, 2693.165118813174, 2761.5443451830424, 2767.33583939855, 2772.1683494951635, 15106.39574417022, 15584.532464025984, 15787.368505259776, 16235.918820405941, 16521.83478165215, 1737.2877120380583, 1775.0592186141366, 1782.1267578886382, 1794.3450640516248, 1807.6023274879506, 107119.92880071177, 129374.0, 132095.0, 134713.0, 137386.6261337394, 11203.831942520868, 11729.941350293195, 11778.882211177779, 11799.174057816042, 11981.023131183258, 14317.35571899267, 14909.030912990622, 14924.92537537327, 14940.32768525419, 14946.850531494545, 8552.871706924401, 8890.288776897833, 8895.911040889638, 8919.375643704878, 9037.322200834964, 8057.59712014397, 8100.878486822702, 8806.427582207265, 8956.149165829236, 8985.640574377083, 7200.531965422231, 7366.77899663011, 7371.852562948819, 7378.852422951511, 7380.372668323145, 1876.2026138890917, 1905.64421333652, 1921.5100149461798, 1922.6539222939725, 1927.4506765571746, 922.5479515037583, 1015.8476228565775, 1028.5063169678597, 1047.1936608811172, 1053.9092039738987, 22643.43391415228, 23152.76847231506, 23202.76797232006, 23237.651435228487, 23256.534869302857, 1060.4485667452882, 1064.4411683865878, 1081.3457857995957, 1102.5755084292446, 1119.9104071674246, 11639.88360116388, 12049.0, 12071.3360765157, 12103.636890893287, 12252.019838412905, 531121.0, 551758.0, 559617.0, 560818.0, 781052.0, 117762.58372108026, 128392.0, 131710.0, 156079.21960390126, 156982.0, 841.9284360829398, 972.7081875437341, 979.3438396274513, 1050.6637875879799, 1055.4247934875511, 19155.329563465213, 19197.616047679247, 19791.60416791685, 19831.0, 19976.800231997495, 54587.45412545982, 55593.0, 57108.85782284248, 57719.422805771406, 58181.70909145597, 84532.57733711292, 86090.0, 86221.0, 86894.56552717196, 87408.56295718481, 7284.453665974967, 8222.506649601042, 8283.58582070882, 8602.010768761673, 8790.824183516166, 11086.0, 13137.60587182386, 13289.269090200132, 13718.65703357424, 13732.244726540137, 10536.315139515908, 11103.722406939569, 11399.601013964802, 11517.193796434169, 11866.347350895438, 11036.668899933014, 11256.155788316073, 11271.323720576791, 11735.941320293345, 11777.764444711229, 9928.305018648625, 10958.01377875995, 11529.0, 11962.820557691815, 12102.394880255775, 7533.434992375484, 7602.1257555381835, 7683.270089341504, 7749.186335434923, 7810.336121429742, 11239.831402528805, 11309.377984210947, 11632.88367116318, 11748.295102293549, 11823.586174484195], "value": 10118.854087815263, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.80052792609, 1441.5242969819958, 1449.6738233897374, 1451.151076620177, 1462.2542503323305, 8045.597720113993, 8452.154784521545, 8456.238938495535, 8472.534010629413, 8480.575971201439, 7432.479726419153, 7652.770416887488, 7657.655405506752, 7976.2821346078845, 8236.876446853303, 2265.4562904902828, 2301.7698230176934, 2301.9884900575476, 2307.746147923727, 2313.5025969416574, 2125.6492678707996, 2322.976770232293, 2334.1013709721797, 2336.9649455258186, 2339.4502291961376, 1858.7862395824518, 2046.3758553641132, 2132.115172203534, 2132.5628246209567, 2318.049599664138, 2259.367377134405, 2272.715910511186, 2277.1346888182384, 2283.3378320287097, 2284.7715228477186, 1974.1215159254139, 2208.2823082498094, 2218.678291647718, 2318.3508617586936, 2335.089315167086, 8347.624356903892, 8429.157084291583, 8431.831363372698, 8450.704225352145, 8452.239298463168, 4465.642748580139, 5050.570701490377, 5170.146925757245, 5233.842984710464, 5239.580833533309, 3286.0, 3474.5656792900886, 3482.3905816482015, 3542.468629705539, 3559.8220088995445, 1130.829591372925, 1161.3786624156037, 1186.0689358853344, 1207.4445754952733, 1231.87681231877, 10919.672409827717, 10950.507227174796, 10951.83572246409, 10954.178436617205, 10999.780004399867, 4574.519675434031, 4695.835645752451, 4723.197056500403, 4800.231962885921, 4804.35141255926, 8264.504129752115, 9525.857112143323, 9636.42181469114, 9639.614415423304, 9643.27675424346, 5275.60432967529, 5283.867903302448, 5286.524212820787, 5292.603054770831, 5306.28365170697, 4620.976895115503, 4701.3653156824075, 4724.905501889943, 4739.597134243559, 4846.951530484721, 3260.3805276997296, 3808.771473711586, 3904.7657140571087, 3946.131850992777, 3960.7623542587535, 1078.4607696151925, 1268.1566758105942, 1276.2789024201297, 1288.5361269942814, 1292.4442489729317, 772.8917951486796, 845.2941793602411, 884.0717246890739, 894.9194572488507, 916.8395530782086, 5487.533559647395, 5518.91721624176, 5687.687177205294, 5804.31671834005, 5853.707314634251, 983.6262220356219, 1007.5667462990838, 1012.4886932099242, 1024.4826362686795, 1040.3237895368072, 3712.276106159327, 3755.3240416724707, 3765.134019175605, 3841.8847434577006, 3865.342891708416, 9741.415515069119, 9775.804483910424, 10017.499125043865, 10072.697819065439, 10119.949400252952, 9738.75653108678, 9767.120959113714, 10043.69868903934, 10045.196384289386, 10105.848412273821, 7734.1492435832015, 7816.6091695416135, 7821.217878212247, 7961.641726122339, 7986.201379861967, 5309.177077552986, 5418.376886658085, 5554.0, 5589.245451864109, 5771.384012476513, 7582.317591416799, 9312.813743725223, 9330.393524420891, 9333.346665733605, 9337.206337461392, 9005.385064555883, 9232.630694772402, 9439.622415103318, 9479.099485548863, 9513.952430237805, 6657.434118099822, 6745.831354216184, 6787.728490860508, 6788.1175447191545, 6789.083473730983, 7622.733204337822, 7693.807654808675, 7804.6878124874365, 7804.843903121792, 7815.8436831261915, 6997.755078572225, 7145.071140751669, 7165.176004759311, 7172.677229524788, 7185.856282874418, 6898.517103802686, 6955.652217389009, 6991.0, 7064.32888875556, 7072.08062951813, 6314.431701146918, 6428.228612566335, 6469.385408386196, 6473.77341793035, 6476.6114033158165, 4774.665773395829, 4919.311296418433, 4964.032013757283, 4972.9254061188385, 5018.4981501849525, 4903.141950158637, 5010.0, 5011.448740638454, 5049.57078648319, 5178.922316165185], "value": 4400.0642136121005, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.2449882531337, 319.1255958673236, 343.4266457509612, 358.9551306086739, 369.38681788231526, 4754.9524504754945, 5029.849104526861, 5178.255524571978, 5215.478452154792, 5329.520343169119, 5219.243209734586, 5223.738813059342, 5302.984865751019, 5340.608713466947, 5359.946400535993, 3157.2264795125225, 3491.6682915123024, 3985.2029594081155, 4176.498820141572, 4222.289972561118, 3485.5817301923676, 3676.981615091921, 3897.1815918656976, 4204.600562946531, 4212.368144778277, 3829.7127715421316, 3972.8410863565423, 4036.132231570212, 4101.293146523295, 4187.743676896934, 3431.6739909708663, 3474.114100904253, 4012.498437695288, 4146.875593732193, 4222.662187025031, 3699.35261329269, 3706.5181526401666, 3714.164313029574, 3721.7208709346637, 3762.8682996095004, 4692.803335149549, 4881.706347817832, 5261.973690131563, 5286.392064912546, 5290.4974027467715, 4176.331786914109, 4282.42187304713, 4562.51718191589, 4646.3495110684535, 4670.10860601457, 4946.788036930975, 5672.971635141798, 5747.2241247431475, 5763.818417224459, 5768.855778605568, 3300.9174770630684, 3385.5298319222993, 3517.7009954153928, 3904.316744569689, 3922.8038598070266, 4974.10466116099, 5320.791871373337, 5360.946390536123, 6018.789342372996, 6049.969750151221, 3840.711946604016, 3863.840847745665, 3887.630675085862, 3896.9019629394697, 3928.6660633846445, 3209.6629853865006, 3444.5866496020135, 3554.9466757998134, 3875.457435958968, 3939.7045221608496, 3602.423612222032, 3935.940960885589, 4291.7768435995595, 4562.5665561771575, 4605.0, 4598.908021839545, 5593.0, 5655.349634791969, 5684.8863022739315, 5693.345265294544, 1194.5938380950518, 1201.5734414282979, 1279.6544932868073, 1316.1773891317926, 1396.8253968253969, 947.331618749311, 981.6907674082642, 982.5234761140841, 986.3785814936688, 1003.533356988989, 4500.504944456107, 4634.967578206982, 4661.254199328091, 5028.547430731179, 5089.6691715038405, 4797.376341075638, 5059.064073146406, 5432.891342173134, 5624.437556244343, 5703.828885133453, 4175.561566035583, 4354.390385346054, 4418.668599854959, 5019.372578427697, 5088.287639730441, 2525.103588226153, 2651.297406187362, 2884.178009267349, 2930.340673348522, 2967.302683869289, 5725.59920805548, 5754.532594188455, 5759.1937128802, 5859.941400586024, 5881.2358191649855, 5264.842054738364, 5424.783008679688, 5636.886167687036, 5660.688662123541, 5669.34802497718, 5660.009498337857, 5841.123831425235, 5845.678487683133, 5845.9707701462075, 5869.735861886225, 4832.323474713613, 4853.538913803183, 5407.188921661782, 5578.553715702653, 5683.9715801420725, 4800.927986080282, 5044.9243261350375, 5307.460836357567, 5461.371942226695, 5507.504324610644, 5199.4540573239265, 5491.983982963165, 5839.138821977116, 5865.882682346414, 5943.851403714942, 3421.794692318469, 3784.924301513899, 3868.0273060738664, 3877.360235561101, 4062.4921884764403, 5246.685198888079, 5447.509724124848, 5615.887682246251, 5637.887242255214, 5651.632643878134, 5131.255967884561, 5180.7150606717, 5224.634275600672, 5599.888002239851, 5600.0, 4986.675866068694, 5237.004969055867, 5411.594130440311, 5641.774329026793, 5651.547876169814, 4641.932355558308, 5045.798168073383, 5102.183650615883, 5473.8357849264585, 5525.640833345819, 5675.858103547279, 5685.289338832646, 5701.971490142523, 5715.199872017838, 5719.685417302088, 5241.633085683966, 5563.8887222256135, 5580.06164544373, 5586.497215250647, 5612.775488980558], "value": 4051.949691189464, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [694.4097517110459, 718.0593422616373, 739.5377888819488, 803.2449497472376, 821.425002498251, 14653.70692586149, 15306.23468826557, 15588.376464941402, 16357.83642163578, 17265.741013884803, 15872.603184920383, 16011.91994040031, 16292.918535407336, 16347.26437310321, 16399.180040997962, 837.2924878477677, 852.1606217875387, 857.7298151082421, 857.8455877941968, 858.4076986879033, 666.6566718140161, 684.9041134241211, 691.3086913086913, 843.6077224090797, 844.624142256696, 862.8662557303596, 885.2077390735288, 891.8350105230521, 892.3619611977435, 895.6596493332524, 875.5665945357025, 878.44218920985, 878.5387671472496, 879.5426378283257, 880.2341962492673, 513.8432778002708, 530.7531997621086, 649.5875119299232, 651.0884761334123, 651.133991790917, 12267.69330766729, 12470.43883025266, 12475.812862807064, 12480.75038499234, 14808.777868331983, 13753.38109785062, 13990.580282591436, 14013.229272390014, 14239.430422783076, 14329.211893345862, 10954.835677464844, 11311.943440282746, 11663.008644265248, 11691.298522088702, 11715.472803723853, 3562.1272788167066, 3588.4079126944025, 3805.448210009533, 3861.7936636396653, 3916.74541154824, 91294.54352728194, 113614.43192784066, 117079.3380070799, 117972.41013794961, 120144.39927800305, 10068.295219334575, 10403.947980260202, 10806.891931080589, 10857.077148442313, 10960.232783705063, 21281.148754049973, 21282.0, 22055.889720551295, 22219.22232721847, 22246.221382251544, 7225.385842203472, 7394.260573942563, 7440.3303702665935, 7638.8923606076805, 7646.541207527566, 4031.173609410064, 4093.63157315843, 4117.547069822317, 4290.678199135077, 4360.7819609019425, 3598.4962105305276, 3700.370936940673, 3707.629237076271, 3709.4992176056426, 3713.164537978933, 518.8599078248851, 640.8045546108482, 646.2600322630561, 646.6734299178978, 647.1716203259834, 655.9114519539896, 670.3196255800367, 697.1529591546195, 700.6251655364356, 735.7876158989741, 9365.438073715462, 9957.302988790716, 10025.19798416125, 10164.0, 10415.635452759117, 632.5256057956533, 666.6201660073491, 676.2392308652766, 705.5413980912448, 725.74598890389, 4307.0, 4469.754163520973, 4624.583787459145, 4743.5967942724565, 4990.4011518618, 86438.0, 96288.51855740676, 98732.50633746928, 99462.0, 101155.0, 79420.20579794128, 85008.724869127, 88470.0, 88560.0, 90381.54809225912, 70002.29997699958, 71011.64494177495, 72104.0, 77384.0, 81502.18497814945, 10197.286189966631, 10680.732981675521, 10912.399818009768, 10958.12335013213, 11009.669709908716, 47515.57453276407, 47923.0, 48444.273335900696, 49411.0, 51102.97794044173, 66882.33117668761, 68573.0, 68592.3140768606, 69816.65091674509, 71895.0, 12397.75204495923, 12856.807147892601, 12945.352732363155, 12988.220706757626, 13055.086143970211, 11514.481848316678, 13766.587002389944, 13766.724665506834, 14523.18460192481, 14662.560123196321, 12483.56307529232, 13387.598372048855, 13388.799168012682, 13420.0, 13857.792133118213, 12413.317267550372, 13190.538331158363, 13513.256770877697, 13664.385102670205, 13882.375293112036, 12703.36483175856, 12777.616671499869, 13060.869391306345, 13141.73716525645, 13511.797323039966, 9468.10309668032, 10662.520186591777, 10890.455477226265, 11097.722556936142, 11554.42227888619, 10550.547471510125, 10683.145348372267, 10686.198535110054, 10691.625793097204, 10707.892921071001], "value": 7394.220425355554, "unit": "score"}], "name": "dromaeo_css", "value": 7317.790530906215, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 113.0, 113.0, 111.0, 113.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 110.0, 109.0, 144.0, 112.0, 110.0, 110.0, 112.0, 132.0, 111.0], "value": 119.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 205.0, 265.0, 201.0, 185.0, 185.0, 183.0, 182.0, 185.0], "value": 196.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 74.0, 82.0, 113.0, 61.0, 59.0, 59.0, 58.0, 73.0, 61.0], "value": 72.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 69.0, 87.0, 70.0, 67.0, 69.0, 83.0, 68.0, 70.0, 82.0], "value": 75.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 92.0, 87.0, 134.0, 130.0, 92.0, 89.0, 91.0, 87.0], "value": 98.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 100.0, 98.0, 98.0, 98.0, 98.0, 98.0, 99.0, 98.0, 99.0], "value": 98.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 87.0, 87.0, 88.0, 87.0, 85.0, 86.0, 84.0, 85.0], "value": 86.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 56.0, 56.0, 57.0, 56.0, 58.0, 57.0, 57.0, 57.0, 57.0], "value": 56.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 75.0, 64.0, 76.0, 71.0, 68.0, 68.0, 68.0, 69.0, 71.0], "value": 69.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 82.0, 86.0, 85.0, 86.0, 82.0, 87.0, 87.0, 121.0], "value": 88.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 138.0, 137.0, 136.0, 133.0, 137.0, 140.0, 138.0, 161.0, 138.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 168.0, 167.0, 165.0, 167.0, 167.0, 165.0, 176.0, 189.0, 205.0], "value": 173.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 66.0, 65.0, 66.0, 65.0, 65.0, 64.0, 65.0], "value": 65.5, "unit": "score"}], "name": "kraken", "value": 1452.6, "alertThreshold": 2.0}]} 16:30:36 INFO - Return code: 0 16:30:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:30:36 ERROR - # TBPL SUCCESS # 16:30:36 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:30:36 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:30:36 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:30:36 INFO - 2017-03-05 16:30:36.438 screenresolution[1663:12353] starting screenresolution argv=screenresolution get 16:30:36 INFO - 2017-03-05 16:30:36.442 screenresolution[1663:12353] Display 0: 1600x1200x32@60 16:30:36 INFO - 2017-03-05 16:30:36.448 screenresolution[1664:12356] starting screenresolution argv=screenresolution list 16:30:36 INFO - Available Modes on Display 0 16:30:36 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:30:36 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:30:36 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:30:36 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:30:36 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:30:36 INFO - Intel Iris: 16:30:36 INFO - Chipset Model: Intel Iris 16:30:36 INFO - Type: GPU 16:30:36 INFO - Bus: Built-In 16:30:36 INFO - VRAM (Dynamic, Max): 1536 MB 16:30:36 INFO - Vendor: Intel (0x8086) 16:30:36 INFO - Device ID: 0x0a2e 16:30:36 INFO - Revision ID: 0x0009 16:30:36 INFO - Displays: 16:30:36 INFO - Display: 16:30:36 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:30:36 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:30:36 INFO - Display Serial Number: 1600x1200 60 16:30:36 INFO - Main Display: Yes 16:30:36 INFO - Mirror: Off 16:30:36 INFO - Online: Yes 16:30:36 INFO - Rotation: Supported 16:30:36 INFO - Return code: 0 16:30:36 INFO - Running post-action listener: _resource_record_post_action 16:30:36 INFO - [mozharness: 2017-03-06 00:30:36.694985Z] Finished run-tests step (success) 16:30:36 INFO - Running post-run listener: _resource_record_post_run 16:30:36 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 42500096; Write bytes: 518442496; Read time: 473; Write time: 1808 16:30:36 INFO - TinderboxPrint: CPU usage
53.7% 16:30:36 INFO - TinderboxPrint: I/O read bytes / time
42,500,096 / 473 16:30:36 INFO - TinderboxPrint: I/O write bytes / time
518,442,496 / 1,808 16:30:36 INFO - TinderboxPrint: CPU idle
2,225.0 (46.3%) 16:30:36 INFO - TinderboxPrint: CPU system
963.5 (20.0%) 16:30:36 INFO - TinderboxPrint: CPU user
1,617.2 (33.7%) 16:30:36 INFO - TinderboxPrint: Swap in / out
239,271,936 / 0 16:30:36 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201478656; Write bytes: 199106560; Read time: 15613; Write time: 366 16:30:36 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 40751104; Write bytes: 306866176; Read time: 451; Write time: 1351 16:30:37 INFO - Running post-run listener: _upload_blobber_files 16:30:37 INFO - Blob upload gear active. 16:30:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:30:37 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 16:30:37 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:30:37 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:30:37 INFO - (blobuploader) - INFO - Open directory for files ... 16:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:30:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:38 INFO - (blobuploader) - INFO - Done attempting. 16:30:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:30:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:39 INFO - (blobuploader) - INFO - Done attempting. 16:30:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 16:30:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:41 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 16:30:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:41 INFO - (blobuploader) - INFO - Done attempting. 16:30:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:30:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:30:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:30:43 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:30:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:30:43 INFO - (blobuploader) - INFO - Done attempting. 16:30:43 INFO - (blobuploader) - INFO - Iteration through files over. 16:30:43 INFO - Return code: 0 16:30:43 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:30:43 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:30:43 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ef8e584c595edba9b142a6311c9b12c03d6b9a4869fefddbc27d67c6e9dfba93659c92f4a306bfb60511691ced099ba1fee4856bd480335fc573b9b853bd829", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05667c2663beae2ee2787c04b73390cdfad2bcc76ed50f9ee8310b1cf04d90f3add458c11adcf5c84768f36894eb08ba33f38ace53f18cc0c4ca0f0da24f4013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60a2b960a0bb1f52425f9f54af99b8c3e43b2e1322ae9bbc936d12feff67ba33014d0e707730367270dca2772b76ec042c5f9d46dac01e76311c9c8645368bff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef6d294077bf07acbd858903d22540f7a1edb0ca757322b93615e05dd77352ad75c8dd862b992df279f912cb0d3881058ba03bcfb2ff6d58e3def501037a461f"} 16:30:43 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:30:43 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:30:43 INFO - Contents: 16:30:43 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ef8e584c595edba9b142a6311c9b12c03d6b9a4869fefddbc27d67c6e9dfba93659c92f4a306bfb60511691ced099ba1fee4856bd480335fc573b9b853bd829", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05667c2663beae2ee2787c04b73390cdfad2bcc76ed50f9ee8310b1cf04d90f3add458c11adcf5c84768f36894eb08ba33f38ace53f18cc0c4ca0f0da24f4013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60a2b960a0bb1f52425f9f54af99b8c3e43b2e1322ae9bbc936d12feff67ba33014d0e707730367270dca2772b76ec042c5f9d46dac01e76311c9c8645368bff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef6d294077bf07acbd858903d22540f7a1edb0ca757322b93615e05dd77352ad75c8dd862b992df279f912cb0d3881058ba03bcfb2ff6d58e3def501037a461f"} 16:30:43 INFO - Running post-run listener: copy_logs_to_upload_dir 16:30:43 INFO - Copying logs to upload dir... 16:30:43 INFO - mkdir: /builds/slave/test/build/upload/logs 16:30:43 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.271462 ========= master_lag: 0.30 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-03-05 16:30:43.930935) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 16:30:43.934634) ========= 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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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/Mozilla-Aurora/sha512/9ef8e584c595edba9b142a6311c9b12c03d6b9a4869fefddbc27d67c6e9dfba93659c92f4a306bfb60511691ced099ba1fee4856bd480335fc573b9b853bd829", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05667c2663beae2ee2787c04b73390cdfad2bcc76ed50f9ee8310b1cf04d90f3add458c11adcf5c84768f36894eb08ba33f38ace53f18cc0c4ca0f0da24f4013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60a2b960a0bb1f52425f9f54af99b8c3e43b2e1322ae9bbc936d12feff67ba33014d0e707730367270dca2772b76ec042c5f9d46dac01e76311c9c8645368bff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef6d294077bf07acbd858903d22540f7a1edb0ca757322b93615e05dd77352ad75c8dd862b992df279f912cb0d3881058ba03bcfb2ff6d58e3def501037a461f"} build_url:https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011231 build_url: 'https://queue.taskcluster.net/v1/task/epYFIGy7Q_usmDV5vzgv-w/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9ef8e584c595edba9b142a6311c9b12c03d6b9a4869fefddbc27d67c6e9dfba93659c92f4a306bfb60511691ced099ba1fee4856bd480335fc573b9b853bd829", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/05667c2663beae2ee2787c04b73390cdfad2bcc76ed50f9ee8310b1cf04d90f3add458c11adcf5c84768f36894eb08ba33f38ace53f18cc0c4ca0f0da24f4013", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/60a2b960a0bb1f52425f9f54af99b8c3e43b2e1322ae9bbc936d12feff67ba33014d0e707730367270dca2772b76ec042c5f9d46dac01e76311c9c8645368bff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ef6d294077bf07acbd858903d22540f7a1edb0ca757322b93615e05dd77352ad75c8dd862b992df279f912cb0d3881058ba03bcfb2ff6d58e3def501037a461f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 16:30:43.971528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 16:30:43.972151) ========= 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.JMTaMtL74Z/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.cp5iLHw1ks/Listeners TMPDIR=/var/folders/wd/qbtztlzd54b5bdbmhc2nsh0w00000w/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.005257 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 16:30:44.023389) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 16:30:44.023893) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 16:30:44.024473) ========= ========= Total master_lag: 0.45 =========