builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0138 starttime: 1482064593.98 results: success (0) buildid: 20161218030213 builduid: 044addfe7d694445be6b59f4f9a3192a revision: a3ce1fce4f15616f66ac328e4a562d0117c93a0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:33.979979) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:33.980401) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:33.980699) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:34.006180) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:34.006530) ========= 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.b6R7drJDns/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.z79u8ei8ey/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 --2016-12-18 04:36:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 155M=0s 2016-12-18 04:36:34 (155 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.127618 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:34.157938) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:34.158930) ========= 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.b6R7drJDns/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.z79u8ei8ey/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.019981 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:34.218205) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 04:36:34.218553) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3ce1fce4f15616f66ac328e4a562d0117c93a0d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a3ce1fce4f15616f66ac328e4a562d0117c93a0d --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b6R7drJDns/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.z79u8ei8ey/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 2016-12-18 04:36:34,290 truncating revision to first 12 chars 2016-12-18 04:36:34,290 Setting DEBUG logging. 2016-12-18 04:36:34,291 attempt 1/10 2016-12-18 04:36:34,291 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3ce1fce4f15?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-18 04:36:35,077 unpacking tar archive at: mozilla-central-a3ce1fce4f15/testing/mozharness/ program finished with exit code 0 elapsedTime=1.039615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-18 04:36:35.281760) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:35.282073) ========= script_repo_revision: a3ce1fce4f15616f66ac328e4a562d0117c93a0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:35.282524) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:35.282855) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-18 04:36:35.310356) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-18 04:36:35.310631) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b6R7drJDns/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.z79u8ei8ey/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:36:35 INFO - MultiFileLogger online at 20161218 04:36:35 in /builds/slave/test 04:36:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:36:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:36:35 INFO - {'append_to_log': False, 04:36:35 INFO - 'base_work_dir': '/builds/slave/test', 04:36:35 INFO - 'blob_upload_branch': 'Firefox', 04:36:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:36:35 INFO - 'branch': 'Firefox', 04:36:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:36:35 INFO - 'config_files': ('talos/mac_config.py',), 04:36:35 INFO - 'default_actions': ('clobber', 04:36:35 INFO - 'read-buildbot-config', 04:36:35 INFO - 'download-and-extract', 04:36:35 INFO - 'populate-webroot', 04:36:35 INFO - 'create-virtualenv', 04:36:35 INFO - 'install', 04:36:35 INFO - 'run-tests'), 04:36:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:36:35 INFO - 'download_minidump_stackwalk': True, 04:36:35 INFO - 'download_symbols': 'ondemand', 04:36:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:36:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:36:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:36:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:36:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:36:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:36:35 INFO - 'installer_path': 'installer.exe', 04:36:35 INFO - 'log_level': 'info', 04:36:35 INFO - 'log_name': 'talos', 04:36:35 INFO - 'log_to_console': True, 04:36:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:36:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:36:35 INFO - 'opt_config_files': (), 04:36:35 INFO - 'pip_index': False, 04:36:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:36:35 INFO - 'cmd': ('bash', 04:36:35 INFO - '-c', 04:36:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:36:35 INFO - 'enabled': True, 04:36:35 INFO - 'halt_on_failure': False, 04:36:35 INFO - 'name': 'check_screen_resolution'},), 04:36:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:36:35 INFO - 'cmd': ('bash', 04:36:35 INFO - '-c', 04:36:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:36:35 INFO - 'enabled': True, 04:36:35 INFO - 'halt_on_failure': False, 04:36:35 INFO - 'name': 'check_screen_resolution'},), 04:36:35 INFO - 'run_cmd_checks_enabled': True, 04:36:35 INFO - 'sps_profile': False, 04:36:35 INFO - 'sps_profile_interval': 0, 04:36:35 INFO - 'suite': 'dromaeojs', 04:36:35 INFO - 'system_bits': '32', 04:36:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:36:35 INFO - 'title': 't-yosemite-r7-0138', 04:36:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:36:35 INFO - 'use_talos_json': True, 04:36:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:36:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:36:35 INFO - 'work_dir': 'build'} 04:36:35 INFO - [mozharness: 2016-12-18 12:36:35.509491Z] Running clobber step. 04:36:35 INFO - Running pre-action listener: _resource_record_pre_action 04:36:35 INFO - Running main action method: clobber 04:36:35 INFO - rmtree: /builds/slave/test/build 04:36:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:36:35 INFO - Running post-action listener: _resource_record_post_action 04:36:35 INFO - [mozharness: 2016-12-18 12:36:35.861854Z] Finished clobber step (success) 04:36:35 INFO - [mozharness: 2016-12-18 12:36:35.862028Z] Running read-buildbot-config step. 04:36:35 INFO - Running pre-action listener: _resource_record_pre_action 04:36:35 INFO - Running main action method: read_buildbot_config 04:36:35 INFO - Using buildbot properties: 04:36:35 INFO - { 04:36:35 INFO - "project": "", 04:36:35 INFO - "product": "firefox", 04:36:35 INFO - "script_repo_revision": "production", 04:36:35 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:36:35 INFO - "repository": "", 04:36:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:36:35 INFO - "buildid": "20161218030213", 04:36:35 INFO - "stage_platform": "macosx64", 04:36:35 INFO - "basedir": "/builds/slave/test", 04:36:35 INFO - "nightly_build": "True", 04:36:35 INFO - "buildnumber": 12, 04:36:35 INFO - "slavename": "t-yosemite-r7-0138", 04:36:35 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:36:35 INFO - "platform": "yosemite_r7", 04:36:35 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:36:35 INFO - "branch": "mozilla-central", 04:36:35 INFO - "repo_path": "mozilla-central", 04:36:35 INFO - "revision": "a3ce1fce4f15616f66ac328e4a562d0117c93a0d", 04:36:35 INFO - "pgo_build": "False", 04:36:35 INFO - "builduid": "044addfe7d694445be6b59f4f9a3192a", 04:36:35 INFO - "slavebuilddir": "test" 04:36:35 INFO - } 04:36:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg. 04:36:35 INFO - Running post-action listener: _resource_record_post_action 04:36:35 INFO - [mozharness: 2016-12-18 12:36:35.865567Z] Finished read-buildbot-config step (success) 04:36:35 INFO - [mozharness: 2016-12-18 12:36:35.865694Z] Running download-and-extract step. 04:36:35 INFO - Running pre-action listener: _resource_record_pre_action 04:36:35 INFO - Running main action method: download_and_extract 04:36:35 INFO - mkdir: /builds/slave/test/build/tests 04:36:35 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')]} 04:36:35 INFO - trying https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json 04:36:35 INFO - Downloading https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:36:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json'}, attempt #1 04:36:37 INFO - Downloaded 1199 bytes. 04:36:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.mac.test_packages.json 04:36:37 INFO - Using the following test package requirements: 04:36:37 INFO - {u'common': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:36:37 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:37 INFO - u'firefox-53.0a1.en-US.mac.cppunittest.tests.zip'], 04:36:37 INFO - u'gtest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:37 INFO - u'firefox-53.0a1.en-US.mac.gtest.tests.zip'], 04:36:37 INFO - u'jittest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:37 INFO - u'jsshell-mac.zip'], 04:36:37 INFO - u'mochitest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:37 INFO - u'firefox-53.0a1.en-US.mac.mochitest.tests.zip'], 04:36:37 INFO - u'mozbase': [u'firefox-53.0a1.en-US.mac.common.tests.zip'], 04:36:37 INFO - u'reftest': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:37 INFO - u'firefox-53.0a1.en-US.mac.reftest.tests.zip'], 04:36:37 INFO - u'talos': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:37 INFO - u'firefox-53.0a1.en-US.mac.talos.tests.zip'], 04:36:37 INFO - u'web-platform': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:37 INFO - u'firefox-53.0a1.en-US.mac.web-platform.tests.zip'], 04:36:37 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.mac.common.tests.zip', 04:36:37 INFO - u'firefox-53.0a1.en-US.mac.xpcshell.tests.zip']} 04:36:37 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:36:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:36:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:36:38 INFO - Expected file size: 16275398 04:36:38 INFO - Obtained file size: 16275398 04:36:44 INFO - Downloading packages: [u'firefox-53.0a1.en-US.mac.common.tests.zip', u'firefox-53.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:36:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip 04:36:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:44 INFO - Fetch https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.common.tests.zip into memory 04:36:45 INFO - Expected file size: 16275398 04:36:45 INFO - Obtained file size: 16275398 04:36:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip 04:36:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:36:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.talos.tests.zip into memory 04:36:53 INFO - Expected file size: 14409734 04:36:53 INFO - Obtained file size: 14409734 04:36:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:53 INFO - trying https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:36:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg 04:36:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg'}, attempt #1 04:36:55 INFO - Downloaded 69641367 bytes. 04:36:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:36:55 INFO - mkdir: /builds/slave/test/properties 04:36:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:55 INFO - Contents: 04:36:55 INFO - build_url:https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg 04:36:56 INFO - Running post-action listener: _resource_record_post_action 04:36:56 INFO - Running post-action listener: set_extra_try_arguments 04:36:56 INFO - [mozharness: 2016-12-18 12:36:56.611425Z] Finished download-and-extract step (success) 04:36:56 INFO - [mozharness: 2016-12-18 12:36:56.611550Z] Running populate-webroot step. 04:36:56 INFO - Running pre-action listener: _resource_record_pre_action 04:36:56 INFO - Running main action method: populate_webroot 04:36:56 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:56 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:56 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:56 INFO - '--tppagecycles', 04:36:56 INFO - '7'], 04:36:56 INFO - 'tests': ['tsvgm']}}, 04:36:56 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:56 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:56 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:56 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:56 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:36:56 INFO - 'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:56 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:36:56 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:56 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:36:56 INFO - 'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['damp', 'tps']}, 04:36:56 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:36:56 INFO - 'tests': ['damp', 'tps']}, 04:36:56 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['dromaeo_dom']}, 04:36:56 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:56 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['basic_compositor_video']}, 04:36:56 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:36:56 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['a11yr', 04:36:56 INFO - 'ts_paint', 04:36:56 INFO - 'tpaint', 04:36:56 INFO - 'sessionrestore', 04:36:56 INFO - 'sessionrestore_no_auto_restore', 04:36:56 INFO - 'tabpaint']}, 04:36:56 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['tsvgx', 04:36:56 INFO - 'tsvgr_opacity', 04:36:56 INFO - 'tart', 04:36:56 INFO - 'tscrollx', 04:36:56 INFO - 'cart', 04:36:56 INFO - 'tsvg_static']}, 04:36:56 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:56 INFO - 'tsvgr_opacity', 04:36:56 INFO - 'tart', 04:36:56 INFO - 'tscrollx', 04:36:56 INFO - 'cart', 04:36:56 INFO - 'tsvg_static']}, 04:36:56 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:36:56 INFO - 'talos_options': ['--disable-e10s'], 04:36:56 INFO - 'tests': ['tp5o']}, 04:36:56 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:36:56 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:36:56 INFO - 'talos_options': ['--disable-e10s', 04:36:56 INFO - '--xperf_path', 04:36:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:56 INFO - 'tests': ['tp5n']}, 04:36:56 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:36:56 INFO - 'talos_options': ['--xperf_path', 04:36:56 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:56 INFO - 'tests': ['tp5n']}}, 04:36:56 INFO - 'talos.zip': {'path': '', 04:36:56 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:56 INFO - Running post-action listener: _resource_record_post_action 04:36:56 INFO - [mozharness: 2016-12-18 12:36:56.629725Z] Finished populate-webroot step (success) 04:36:56 INFO - [mozharness: 2016-12-18 12:36:56.629858Z] Running create-virtualenv step. 04:36:56 INFO - Running pre-action listener: _resource_record_pre_action 04:36:56 INFO - Running main action method: create_virtualenv 04:36:56 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:56 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 04:36:56 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:56 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:56 INFO - Using real prefix '/tools/python27' 04:36:56 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:57 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:00 INFO - Installing pip.................done. 04:37:00 INFO - Return code: 0 04:37:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:37:00 INFO - Reading from file tmpfile_stdout 04:37:00 INFO - Output received: 04:37:00 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) 04:37:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:00 INFO - 'HOME': '/Users/cltbld', 04:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:00 INFO - 'LOGNAME': 'cltbld', 04:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:00 INFO - 'MOZ_NO_REMOTE': '1', 04:37:00 INFO - 'NO_EM_RESTART': '1', 04:37:00 INFO - 'PAGER': '/bin/cat', 04:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:00 INFO - 'PWD': '/builds/slave/test', 04:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:00 INFO - 'SHELL': '/bin/bash', 04:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:00 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:00 INFO - 'USER': 'cltbld', 04:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:00 INFO - 'XPC_FLAGS': '0x0', 04:37:00 INFO - 'XPC_SERVICE_NAME': '0', 04:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:00 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 04:37:00 INFO - Cleaning up... 04:37:00 INFO - Return code: 0 04:37:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:37:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:37:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:00 INFO - 'HOME': '/Users/cltbld', 04:37:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:00 INFO - 'LOGNAME': 'cltbld', 04:37:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:00 INFO - 'MOZ_NO_REMOTE': '1', 04:37:00 INFO - 'NO_EM_RESTART': '1', 04:37:00 INFO - 'PAGER': '/bin/cat', 04:37:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:00 INFO - 'PWD': '/builds/slave/test', 04:37:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:00 INFO - 'SHELL': '/bin/bash', 04:37:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:00 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:00 INFO - 'USER': 'cltbld', 04:37:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:00 INFO - 'XPC_FLAGS': '0x0', 04:37:00 INFO - 'XPC_SERVICE_NAME': '0', 04:37:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:01 INFO - Downloading/unpacking psutil>=3.1.1 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:05 INFO - Installing collected packages: psutil 04:37:05 INFO - Running setup.py install for psutil 04:37:05 INFO - building 'psutil._psutil_osx' extension 04:37:05 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 04:37:05 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 04:37:05 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 04:37:05 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 04:37:05 INFO - building 'psutil._psutil_posix' extension 04:37:05 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 04:37:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:37:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:37:05 INFO - ^ 04:37:05 INFO - 1 warning generated. 04:37:05 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 04:37:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:05 INFO - Successfully installed psutil 04:37:05 INFO - Cleaning up... 04:37:06 INFO - Return code: 0 04:37:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:37: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 mozsystemmonitor==0.3 04:37:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:06 INFO - 'HOME': '/Users/cltbld', 04:37:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:06 INFO - 'LOGNAME': 'cltbld', 04:37:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:06 INFO - 'MOZ_NO_REMOTE': '1', 04:37:06 INFO - 'NO_EM_RESTART': '1', 04:37:06 INFO - 'PAGER': '/bin/cat', 04:37:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:06 INFO - 'PWD': '/builds/slave/test', 04:37:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:06 INFO - 'SHELL': '/bin/bash', 04:37:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:06 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:06 INFO - 'USER': 'cltbld', 04:37:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:06 INFO - 'XPC_FLAGS': '0x0', 04:37:06 INFO - 'XPC_SERVICE_NAME': '0', 04:37:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:37:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:37:09 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:37:09 INFO - Installing collected packages: mozsystemmonitor 04:37:09 INFO - Running setup.py install for mozsystemmonitor 04:37:09 INFO - Successfully installed mozsystemmonitor 04:37:09 INFO - Cleaning up... 04:37:09 INFO - Return code: 0 04:37:09 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:37:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:37:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:09 INFO - 'HOME': '/Users/cltbld', 04:37:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:09 INFO - 'LOGNAME': 'cltbld', 04:37:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:09 INFO - 'MOZ_NO_REMOTE': '1', 04:37:09 INFO - 'NO_EM_RESTART': '1', 04:37:09 INFO - 'PAGER': '/bin/cat', 04:37:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:09 INFO - 'PWD': '/builds/slave/test', 04:37:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:09 INFO - 'SHELL': '/bin/bash', 04:37:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:09 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:09 INFO - 'USER': 'cltbld', 04:37:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:09 INFO - 'XPC_FLAGS': '0x0', 04:37:09 INFO - 'XPC_SERVICE_NAME': '0', 04:37:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:09 INFO - Downloading/unpacking jsonschema==2.5.1 04:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:37:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37: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 04:37:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:37:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:37:12 INFO - warning: no files found matching '*.txt' 04:37:12 INFO - no previously-included directories found matching 'build' 04:37:12 INFO - no previously-included directories found matching 'dist' 04:37:12 INFO - no previously-included directories found matching '.git*' 04:37:12 INFO - Installing collected packages: jsonschema, functools32 04:37:12 INFO - Running setup.py install for functools32 04:37:12 INFO - warning: no files found matching '*.txt' 04:37:12 INFO - no previously-included directories found matching 'build' 04:37:12 INFO - no previously-included directories found matching 'dist' 04:37:12 INFO - no previously-included directories found matching '.git*' 04:37:12 INFO - Successfully installed jsonschema functools32 04:37:12 INFO - Cleaning up... 04:37:12 INFO - Return code: 0 04:37:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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', '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 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:37: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 functools32==3.2.3-2 04:37:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:12 INFO - 'HOME': '/Users/cltbld', 04:37:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:12 INFO - 'LOGNAME': 'cltbld', 04:37:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:12 INFO - 'MOZ_NO_REMOTE': '1', 04:37:12 INFO - 'NO_EM_RESTART': '1', 04:37:12 INFO - 'PAGER': '/bin/cat', 04:37:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:12 INFO - 'PWD': '/builds/slave/test', 04:37:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:12 INFO - 'SHELL': '/bin/bash', 04:37:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:12 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:12 INFO - 'USER': 'cltbld', 04:37:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:12 INFO - 'XPC_FLAGS': '0x0', 04:37:12 INFO - 'XPC_SERVICE_NAME': '0', 04:37:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:37:13 INFO - Cleaning up... 04:37:13 INFO - Return code: 0 04:37:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:13 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 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37:13 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 04:37:13 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 04:37:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:13 INFO - 'HOME': '/Users/cltbld', 04:37:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:13 INFO - 'LOGNAME': 'cltbld', 04:37:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:13 INFO - 'MOZ_NO_REMOTE': '1', 04:37:13 INFO - 'NO_EM_RESTART': '1', 04:37:13 INFO - 'PAGER': '/bin/cat', 04:37:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:13 INFO - 'PWD': '/builds/slave/test', 04:37:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:13 INFO - 'SHELL': '/bin/bash', 04:37:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:13 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:13 INFO - 'USER': 'cltbld', 04:37:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:13 INFO - 'XPC_FLAGS': '0x0', 04:37:13 INFO - 'XPC_SERVICE_NAME': '0', 04:37:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:37:13 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 04:37:13 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 04:37:13 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 04:37:13 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 04:37:13 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 04:37:13 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 04:37:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:37:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:37:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:17 INFO - Downloading docopt-0.6.1.tar.gz 04:37:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:37:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:37:17 INFO - Running setup.py install for blobuploader 04:37:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:37:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:37:17 INFO - Running setup.py install for requests 04:37:18 INFO - Running setup.py install for docopt 04:37:18 INFO - Successfully installed blobuploader requests docopt 04:37:18 INFO - Cleaning up... 04:37:18 INFO - Return code: 0 04:37:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:18 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 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37:18 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 04:37:18 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 04:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:18 INFO - 'HOME': '/Users/cltbld', 04:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:18 INFO - 'LOGNAME': 'cltbld', 04:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:18 INFO - 'MOZ_NO_REMOTE': '1', 04:37:18 INFO - 'NO_EM_RESTART': '1', 04:37:18 INFO - 'PAGER': '/bin/cat', 04:37:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:18 INFO - 'PWD': '/builds/slave/test', 04:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:18 INFO - 'SHELL': '/bin/bash', 04:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:18 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:18 INFO - 'USER': 'cltbld', 04:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:18 INFO - 'XPC_FLAGS': '0x0', 04:37:18 INFO - 'XPC_SERVICE_NAME': '0', 04:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:18 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ROff_v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:18 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-jsiQzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:18 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-wIQIB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:18 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-n6NZsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:18 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-9opsHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-8nb4ww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-EWmmHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ApBwKD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-4IbJTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-wfUSmo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-15wCxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-0F8EMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-hdaI2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:19 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-HqQ4yS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:20 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-qchhhL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:20 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-DOmDen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:20 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-9iclNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:37:20 INFO - Running setup.py install for manifestparser 04:37:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:37:20 INFO - Running setup.py install for mozcrash 04:37:20 INFO - Running setup.py install for mozdebug 04:37:20 INFO - Running setup.py install for mozdevice 04:37:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:37:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:37:20 INFO - Running setup.py install for mozfile 04:37:21 INFO - Running setup.py install for mozhttpd 04:37:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:37:21 INFO - Running setup.py install for mozinfo 04:37:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:37:21 INFO - Running setup.py install for mozInstall 04:37:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:37:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:37:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:37:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:37:21 INFO - Running setup.py install for mozleak 04:37:21 INFO - Running setup.py install for mozlog 04:37:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:37:21 INFO - Running setup.py install for moznetwork 04:37:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:37:21 INFO - Running setup.py install for mozprocess 04:37:22 INFO - Running setup.py install for mozprofile 04:37:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:37:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:37:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:37:22 INFO - Running setup.py install for mozrunner 04:37:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:37:22 INFO - Running setup.py install for mozscreenshot 04:37:22 INFO - Running setup.py install for moztest 04:37:22 INFO - Running setup.py install for mozversion 04:37:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:37:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:37:22 INFO - Cleaning up... 04:37:22 INFO - Return code: 0 04:37:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37:22 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')]} 04:37:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:22 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')]} 04:37:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:22 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 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37:22 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 04:37:22 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 04:37:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:22 INFO - 'HOME': '/Users/cltbld', 04:37:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:22 INFO - 'LOGNAME': 'cltbld', 04:37:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:22 INFO - 'MOZ_NO_REMOTE': '1', 04:37:22 INFO - 'NO_EM_RESTART': '1', 04:37:22 INFO - 'PAGER': '/bin/cat', 04:37:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:22 INFO - 'PWD': '/builds/slave/test', 04:37:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:22 INFO - 'SHELL': '/bin/bash', 04:37:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:22 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:22 INFO - 'USER': 'cltbld', 04:37:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:22 INFO - 'XPC_FLAGS': '0x0', 04:37:22 INFO - 'XPC_SERVICE_NAME': '0', 04:37:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:37:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-b_b13n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:37:23 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)) 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:37:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-uska3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:37:23 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)) 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:37:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ABFb40-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:37:23 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)) 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:37:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-0g4hqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:37:23 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)) 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:37:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-l9Sce5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:37:23 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)) 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:37:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-mTBiPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:37:23 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)) 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:37:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-X5jwO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:37:23 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)) 04:37:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:37:23 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-FbOPdQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:37:24 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)) 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:37:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ahmkYd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:37:24 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)) 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:37:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-hnVYyF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:37:24 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)) 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:37:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-isVVXB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:37:24 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)) 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:37:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-U9Wt79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:37:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-np514p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:37:24 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)) 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:37:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-zFWpzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:37:24 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)) 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-ZGRqyr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:37:24 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)) 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:37:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-i3zgLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:37:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 04:37:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:37:24 INFO - Running setup.py (path:/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/pip-7c2HBO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:37:25 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)) 04:37:25 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)) 04:37:25 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)) 04:37:25 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)) 04:37:25 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)) 04:37:25 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)) 04:37:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:37:25 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 04:37:25 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 04:37:25 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 04:37:25 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 04:37:25 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 04:37:25 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 04:37:27 INFO - Downloading blessings-1.6.tar.gz 04:37:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:37:27 INFO - Installing collected packages: blessings 04:37:27 INFO - Running setup.py install for blessings 04:37:27 INFO - Successfully installed blessings 04:37:27 INFO - Cleaning up... 04:37:28 INFO - Return code: 0 04:37:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:28 INFO - Reading from file tmpfile_stdout 04:37:28 INFO - Current package versions: 04:37:28 INFO - blessings == 1.6 04:37:28 INFO - blobuploader == 1.2.4 04:37:28 INFO - docopt == 0.6.1 04:37:28 INFO - functools32 == 3.2.3-2 04:37:28 INFO - jsonschema == 2.5.1 04:37:28 INFO - manifestparser == 1.1 04:37:28 INFO - mozInstall == 1.12 04:37:28 INFO - mozcrash == 1.0 04:37:28 INFO - mozdebug == 0.1 04:37:28 INFO - mozdevice == 0.49 04:37:28 INFO - mozfile == 1.2 04:37:28 INFO - mozhttpd == 0.7 04:37:28 INFO - mozinfo == 0.9 04:37:28 INFO - mozleak == 0.1 04:37:28 INFO - mozlog == 3.4 04:37:28 INFO - moznetwork == 0.27 04:37:28 INFO - mozprocess == 0.23 04:37:28 INFO - mozprofile == 0.28 04:37:28 INFO - mozrunner == 6.13 04:37:28 INFO - mozscreenshot == 0.1 04:37:28 INFO - mozsystemmonitor == 0.3 04:37:28 INFO - moztest == 0.7 04:37:28 INFO - mozversion == 1.4 04:37:28 INFO - psutil == 3.1.1 04:37:28 INFO - requests == 1.2.3 04:37:28 INFO - wsgiref == 0.1.2 04:37:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:28 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 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37:28 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 04:37:28 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 04:37:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:28 INFO - 'HOME': '/Users/cltbld', 04:37:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:28 INFO - 'LOGNAME': 'cltbld', 04:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:28 INFO - 'MOZ_NO_REMOTE': '1', 04:37:28 INFO - 'NO_EM_RESTART': '1', 04:37:28 INFO - 'PAGER': '/bin/cat', 04:37:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:28 INFO - 'PWD': '/builds/slave/test', 04:37:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:28 INFO - 'SHELL': '/bin/bash', 04:37:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:28 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:28 INFO - 'USER': 'cltbld', 04:37:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:28 INFO - 'XPC_FLAGS': '0x0', 04:37:28 INFO - 'XPC_SERVICE_NAME': '0', 04:37:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:28 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)) 04:37:28 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)) 04:37:28 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)) 04:37:28 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)) 04:37:28 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)) 04:37:28 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)) 04:37:28 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)) 04:37:28 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)) 04:37:28 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)) 04:37:28 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)) 04:37:28 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)) 04:37:28 INFO - Cleaning up... 04:37:28 INFO - Return code: 0 04:37:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:37: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')]} 04:37:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37: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')]} 04:37:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:28 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 0x10e508b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e50b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc75046f060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, '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.b6R7drJDns/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.z79u8ei8ey/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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 04:37:28 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 04:37:28 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 04:37:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:28 INFO - 'HOME': '/Users/cltbld', 04:37:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:28 INFO - 'LOGNAME': 'cltbld', 04:37:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:28 INFO - 'MOZ_NO_REMOTE': '1', 04:37:28 INFO - 'NO_EM_RESTART': '1', 04:37:28 INFO - 'PAGER': '/bin/cat', 04:37:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:28 INFO - 'PWD': '/builds/slave/test', 04:37:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:28 INFO - 'SHELL': '/bin/bash', 04:37:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:28 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:28 INFO - 'USER': 'cltbld', 04:37:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:28 INFO - 'XPC_FLAGS': '0x0', 04:37:28 INFO - 'XPC_SERVICE_NAME': '0', 04:37:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:28 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:37:28 INFO - Cleaning up... 04:37:28 INFO - Return code: 0 04:37:28 INFO - Running post-action listener: _resource_record_post_action 04:37:28 INFO - Running post-action listener: _start_resource_monitoring 04:37:28 INFO - Starting resource monitoring. 04:37:28 INFO - [mozharness: 2016-12-18 12:37:28.869174Z] Finished create-virtualenv step (success) 04:37:28 INFO - [mozharness: 2016-12-18 12:37:28.870026Z] Running install step. 04:37:28 INFO - Running pre-action listener: _resource_record_pre_action 04:37:28 INFO - Running main action method: install 04:37:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:37:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:37:29 INFO - Reading from file tmpfile_stdout 04:37:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:37:29 INFO - Reading from file tmpfile_stdout 04:37:29 INFO - Output received: 04:37:29 INFO - Usage: mozinstall [options] installer 04:37:29 INFO - Options: 04:37:29 INFO - -h, --help show this help message and exit 04:37:29 INFO - -d DEST, --destination=DEST 04:37:29 INFO - Directory to install application into. [default: 04:37:29 INFO - "/builds/slave/test"] 04:37:29 INFO - --app=APP Application being installed. [default: firefox] 04:37:29 INFO - mkdir: /builds/slave/test/build/application 04:37:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:37:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:37:50 INFO - Reading from file tmpfile_stdout 04:37:50 INFO - Output received: 04:37:50 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:37:50 INFO - Running post-action listener: _resource_record_post_action 04:37:50 INFO - [mozharness: 2016-12-18 12:37:50.855448Z] Finished install step (success) 04:37:50 INFO - [mozharness: 2016-12-18 12:37:50.855598Z] Running run-tests step. 04:37:50 INFO - Running pre-action listener: _resource_record_pre_action 04:37:50 INFO - Running main action method: run_tests 04:37:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:37:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:37:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:37:50 INFO - 2016-12-18 04:37:50.870 screenresolution[2353:296798] starting screenresolution argv=screenresolution get 04:37:50 INFO - 2016-12-18 04:37:50.873 screenresolution[2353:296798] Display 0: 1600x1200x32@60 04:37:50 INFO - 2016-12-18 04:37:50.879 screenresolution[2354:296801] starting screenresolution argv=screenresolution list 04:37:50 INFO - Available Modes on Display 0 04:37:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:37:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:37:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:37:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:37:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:37:51 INFO - Intel Iris: 04:37:51 INFO - Chipset Model: Intel Iris 04:37:51 INFO - Type: GPU 04:37:51 INFO - Bus: Built-In 04:37:51 INFO - VRAM (Dynamic, Max): 1536 MB 04:37:51 INFO - Vendor: Intel (0x8086) 04:37:51 INFO - Device ID: 0x0a2e 04:37:51 INFO - Revision ID: 0x0009 04:37:51 INFO - Displays: 04:37:51 INFO - Display: 04:37:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:37:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:37:51 INFO - Display Serial Number: 1600x1200 60 04:37:51 INFO - Main Display: Yes 04:37:51 INFO - Mirror: Off 04:37:51 INFO - Online: Yes 04:37:51 INFO - Rotation: Supported 04:37:51 INFO - Return code: 0 04:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:51 INFO - Python 2.7.3 04:37:51 INFO - Return code: 0 04:37:51 INFO - grabbing minidump binary from tooltool 04:37:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:51 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 0x10e2e6d30>, '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 0x10e20ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10e2dbbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:51 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 04:37:51 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 04:37:51 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 04:37:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:51 INFO - Return code: 0 04:37:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:37:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:37:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 04:37:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0138 --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 04:37:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b6R7drJDns/Render', 04:37:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:51 INFO - 'HOME': '/Users/cltbld', 04:37:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:51 INFO - 'LOGNAME': 'cltbld', 04:37:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:37:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:51 INFO - 'MOZ_NO_REMOTE': '1', 04:37:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:51 INFO - 'NO_EM_RESTART': '1', 04:37:51 INFO - 'PAGER': '/bin/cat', 04:37:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:51 INFO - 'PWD': '/builds/slave/test', 04:37:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:51 INFO - 'SHELL': '/bin/bash', 04:37:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.z79u8ei8ey/Listeners', 04:37:51 INFO - 'TMPDIR': '/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/', 04:37:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:51 INFO - 'USER': 'cltbld', 04:37:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:51 INFO - 'XPC_FLAGS': '0x0', 04:37:51 INFO - 'XPC_SERVICE_NAME': '0', 04:37:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0138', '--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 04:37:51 INFO - mozversion application_buildid: 20161218030213 04:37:51 INFO - mozversion application_changeset: a3ce1fce4f15616f66ac328e4a562d0117c93a0d 04:37:51 INFO - mozversion application_display_name: Nightly 04:37:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:51 INFO - mozversion application_name: Firefox 04:37:51 INFO - mozversion application_remotingname: firefox 04:37:51 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:37:51 INFO - mozversion application_vendor: Mozilla 04:37:51 INFO - mozversion application_version: 53.0a1 04:37:51 INFO - mozversion platform_buildid: 20161218030213 04:37:51 INFO - mozversion platform_changeset: a3ce1fce4f15616f66ac328e4a562d0117c93a0d 04:37:51 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:37:51 INFO - mozversion platform_version: 53.0a1 04:37:51 INFO - using testdate: 1482064671 04:37:51 INFO - actual date: 1482064671 04:37:51 INFO - starting webserver on 'localhost:53190' 04:37:51 INFO - SUITE-START | Running 2 tests 04:37:51 INFO - TEST-START | dromaeo_css 04:37:51 INFO - operating with platform_type : mac_ 04:37:51 INFO - Initialising browser for dromaeo_css test... 04:37:51 INFO - TEST-INFO | started process 2364 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpAotXJN/profile http://localhost:53190/getInfo.html) 04:37:54 INFO - PROCESS | 2364 | __metrics Screen width/height:1600/1200 04:37:54 INFO - PROCESS | 2364 | colorDepth:24 04:37:54 INFO - PROCESS | 2364 | Browser inner width/height: 1024/689 04:37:54 INFO - PROCESS | 2364 | __metrics 04:37:54 INFO - PROCESS | 2364 | 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" 04:37:54 INFO - PROCESS | 2364 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:55 INFO - TEST-INFO | 2364: exit 0 04:37:55 INFO - Browser initialized. 04:37:55 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:55 INFO - TEST-INFO | started process 2367 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpAotXJN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:38:07 INFO - PROCESS | 2367 | RSS: Main: 237101056 04:38:07 INFO - PROCESS | 2367 | 04:38:58 INFO - PROCESS | 2367 | 1482064738432 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:41:12 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:53190/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53190/tests/dromaeo/cssquery-ext.html) 04:41:14 INFO - PROCESS | 2367 | RSS: Main: 403030016 04:41:14 INFO - PROCESS | 2367 | 04:44:17 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:53190/tests/dromaeo/cssquery-ext.html (next: http://localhost:53190/tests/dromaeo/cssquery-jquery.html) 04:44:17 INFO - PROCESS | 2367 | RSS: Main: 371216384 04:44:17 INFO - PROCESS | 2367 | 04:47:20 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:53190/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53190/tests/dromaeo/cssquery-mootools.html) 04:47:21 INFO - PROCESS | 2367 | RSS: Main: 365481984 04:47:21 INFO - PROCESS | 2367 | 04:50:23 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:53190/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53190/tests/dromaeo/cssquery-prototype.html) 04:50:24 INFO - PROCESS | 2367 | RSS: Main: 338563072 04:50:24 INFO - PROCESS | 2367 | 04:53:27 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:53190/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53190/tests/dromaeo/cssquery-yui.html) 04:53:28 INFO - PROCESS | 2367 | RSS: Main: 334385152 04:53:28 INFO - PROCESS | 2367 | 04:56:32 INFO - PROCESS | 2367 | Cycle 1(1): loaded http://localhost:53190/tests/dromaeo/cssquery-yui.html (next: http://localhost:53190/tests/dromaeo/cssquery-dojo.html) 04:56:32 INFO - PROCESS | 2367 | RSS: Main: 388800512 04:56:32 INFO - PROCESS | 2367 | 04:56:32 INFO - PROCESS | 2367 | __start_tp_report 04:56:32 INFO - PROCESS | 2367 | _x_x_mozilla_page_load 04:56:32 INFO - PROCESS | 2367 | _x_x_mozilla_page_load_details 04:56:32 INFO - PROCESS | 2367 | |i|pagename|runs| 04:56:32 INFO - PROCESS | 2367 | |0;dojo.html;3198.648148703642;3216.6972376187646;3252.983735081326;3253.7234335081516;3283.491058885872;5292.550133238669;5386.380566234884;5428.185772134182;5441.401445840959;5493.340799104109;5410.404855465906;5435.673859568428;5514.724263786805;5520.806771762989;5521.503064724174;4958.975205123969;4965.975170124162;4978.352814134158;5018.573421259197;5036.143855544567;5021.698698078127;5114.948850511503;5115.360579927509;5135.332406787131;5193.298904647881;4941.160002799496;5072.0870243356185;5087.287779710843;5108.310378098946;5188.273641690166;4973.154563724175;5000.799968001275;5049.1164046292115;5055.115354812893;5069.645124841262;4955.82654607087;4985.426675932278;5022;5030.346055012861;5061.16490779021;5416.702081385522;5428.891422171574;5442.292501974757;5444;5446.673199608036;5675.148727690838;5736.196932429463;5745.798897038583;5769.24999750034;5863.648181109147;5913.526917846562;5921.259842519685;5931.4661680448535;5988.730507127189;5999.850003749898;5496.917546236809;5511.559075273968;5517.917231241535;5527.115661494142;5541.196526503675;6059.7273122709585;6060;6124.846878828065;6140.969295153495;6179.2584889812615;4719.4100737407825;5618.410066942994;5698.401667824902;5712.6286791358425;5717.085266357363;5854.531637468992;5857.7656893724625;5859.882802344015;5879.059350503899;5879.2944846618675;5708.914366284509;5759.798407055733;5761.740721667535;5775.27809023872;5776.624519406225;5792.304923409218;5792.420757924258;5808.215890854765;5815.534757219497;5818.650880947157;4124.855630052994;4595.4025976622825;4684.320773487825;4687.62499000086;4693.882652933704;4150.875473735793;4159.812808423628;4160.875173744793;4170.937435938464;4234.428352172417;5481.725913704299;5482.451754824566;5505.394406615269;5507.807226747044;5557.6109672323355;5891.558133139946;5927.703614819242;5945.137954996501;5946.13781001761;5958.6722730249385;5395.81114660985;5454.318210223722;5457.972710136424;5480;5520.392756796749;5131.589472842164;5172.637915345889;5176.145935920531;5200.959808038408;5225.555827754683;6277.1525844010475;6308.3060863305;6320.905186422299;6326.746930122744;6336.081268216083;5429.131338985743;5848.824535263949;5954.553408494294;5972.432618901197;5976.611520251344;6159.753609855556;6195.597286176384;6216;6237.251529816451;6246.718897649525;5834.766609335748;5847.1229315603;5850.473457388855;5856.209411729362;5871.970640146943;5857.092150716646;5869.882602347844;5911.290645122613;5920.674362910081;5924.318703348998;5606.24315717373;5656.1233008882045;5676.063449530781;5686.886262274648;5750.396208398058;5734.139879018014;5798.913016304675;5800.738966746591;5808.651480911159;5809.5933284671355;5618.101103823368;5651.689157096399;5652.236948011966;5661.094224923992;5671.234383358359;5628.971855140698;5705.37240903492;5716.571257155813;5728.198052272602;5774.48029677331;5510.779568817203;5542.3903370630005;5569.582281328835;5575.968445837533;5590.385057643574 04:56:32 INFO - PROCESS | 2367 | |1;ext.html;394.93286141355975;479.55401476626764;487.93656824612793;488.45049319515545;494.47585559307134;30828.69171308289;32152.35695286093;32181.51727724086;32224.67775322249;40866.773996780146;38273.66042188524;40075;40342.59657403425;42770.14459710804;42942.14115717684;9343.532823358822;9567.138957493824;9571.18644915183;9583.28125390595;9597.136257736802;8481.109483504204;8684.739457816275;9392.7651808705;9501.334906556544;11180;9881.901180988207;11256.493457794419;11291;11475.254108482923;11542.826857597143;11380.658580242605;11402.94298528502;11445.713857153554;11488.483018264198;11491.885081149165;8393.958030209871;8613.569321533962;11100.55597776088;11341.319520828776;11400.94299528497;40125.799371002955;40417.39373909364;40481;40505.59494405048;40517;3339.7328213742844;3447.775894566845;3530.276293359855;3548.4854696069183;3756.2487502499607;28007.719922800716;28739;29190.562141567894;29583.85208073946;29607.703922960925;3119.7036281553214;3142.8899988500293;3182.220356012792;3246.951295730566;3252.560904277916;469264;472369;473140.63429682975;473673;477867;55818.441815581325;56175.71912140413;56204.15693764597;56316.43683563194;56395;56015;56071.43928560744;56196.43803561994;56251;56288.437115628316;15162.696746065238;15794.973326733725;15825.683486330208;15834.208289585706;15858.224810658088;12223.449944752507;12351.19717218378;12360.94931930778;12371.40200557893;12372.876271237352;15296.311665975058;15619.906606537434;15654.608634784221;17112.005399055117;17598;7370.336669699753;7553.395728341719;7563.336066065457;7576.507527010726;7645.923540764521;866.787637028932;928.3965422475445;950.3632566180676;982.1651596143364;1025.0518270599666;29118.854405727834;29404.264893377407;30202;30443;30787.384252315278;1023.4217667018111;1081.2107161771794;1091.912646988239;1106.4578356605205;1124.6569796212234;15024.924875375553;15364.846351536342;15755.606109847116;15777.447789327318;15981.671619835028;183743;184182;184324;184468;184787;59697.70151149217;60353;60386.39613603808;60440.395596044356;60695.39304606897;1392.4291040673274;1392.7562676531566;1411.470698488067;1418.3475601223347;1422.8008078868759;29072.563911541765;29612.407751845272;29666;30517.694823051486;30552.08343749691;51962.22056669229;52211.47788522066;52439;52486.737566311924;52602.47397526129;515089.4245528748;519805;519898;520668;520681;26618;26846;27184.864075679496;27260.31849203786;27284.454310913272;33306.500402494465;39043.82868513949;39514.40728389019;41418;47910.520894792004;35964.28071438609;38675.806620966716;39449.40825887671;39670;41200.1759964805;38867.80566097151;39025.024374390865;39156.216875662896;40373;40603.390949135195;38437.615623843405;38791.6120838788;38926;39114;39199.216015678954;32910.34179316353;34356.845643953704;34526.82736586301;34916.30167396587;34926.82536587402;25250.36874078163;25401.237962861145;25413.237602871945;25634.743652563237;25718 04:56:32 INFO - PROCESS | 2367 | |2;jquery.html;356.2998707539684;367.9392900171472;375.93233218020765;383.6163836163837;406.1248010537293;11155.05182059526;11628.709282267926;14062;14661.926690366547;19577.412677619657;21089.367318980454;21400.57198856022;22099.889500552476;22281;22418.215362462317;6149.231346081729;6649.00264960255;6716.429103526206;6718.865622687544;6734.764283250087;4507.639388848901;4695.71825690458;4756.571908528232;6605.801825945229;6755.1893772747335;7583.355414789722;7645.808854778619;7661.502002369856;7670.578118203496;7670.654820533089;7306.159791623978;7517.060367454068;7586.8482630347635;7601.733939312153;7639.656215470317;7051.929480705178;7294.1247050354295;7316.963415182943;7333.376662983653;7342.339189472919;26672.06647767319;26675.599866002027;27220.455590888072;27578.89684412621;27863;2297.7245402324556;2373.8219633527556;2413.879306034709;2473.418746594549;3225.435663703102;16255.26851291683;16356.918215408847;16584;16630.085345306004;17210.82789172105;1855.1651756709534;1859.8605104617072;1894.9242030318771;1996.920123195085;2056.4036429435446;124683;128109;130104;130631.34684326613;131385;20068.498287542636;21179.163709427612;21182.47043823917;21350.679739803916;21412.25057122993;28133;29322.706772932423;31321.06036818899;33017.834910825295;33035.504467433006;8364.414490985695;8529.829403411897;10181.74545636365;10682.288077188121;10851.364792794344;7978.3218426434405;8841.69054083104;8855.38012339143;8978.191962723386;8981.640734370683;8801.779955501035;9599.088086631758;9642.807143857084;9716.708498745049;9754.512274386252;3041.422129795332;3620.330238905811;3621.511096002006;3634.2186429917697;3681.8895433136513;369.9334119858451;379.75316044570695;403.1614242375851;838.379599096664;895.6999405199201;11646.24299420535;11671.76656466883;11829.290242585472;12092;12102.939485302517;387.73827666325116;413.1530362756337;418.37870761918526;428.7041941060658;431.764688244901;4939.382577177853;5951.851203719855;5960.956832554286;6173;6183.041628547582;499650.5017474962;503162;533800;538949;552029;64082;113994;127627.36186319009;129049;129885;432.3968064549998;442.8627125591077;443.33057083803686;446.08552467442263;447.44293354773515;11203.327800332007;11391.259568128045;11459.31244125355;18161;19214.423567293004;53136;53658.658533536975;54049;54158.72920635529;55499.22503874871;56728.432715672316;69642;72741.6362918182;74761;76941.61529192318;7909.05091389037;8013.118556958613;8186.2632363087605;8224.794380140305;8246.711365102192;12606.810897836724;12731.37155910561;12821;12934.223946562859;12950.352482376033;9211.355205135576;10826.729331766768;11000.394978276272;11354.205205635526;11382;10214.642487512901;10718.946405267923;10782.622608208674;10883.401412922365;11348.943255283672;11087.778244435227;11267.042301404472;11337.773244534897;11460.713482162679;11631.418429078682;5992.310884248367;7776.377889768918;7991.24083212094;8211.343092552463;8434.240918317135;9332.673356432764;11121.721956951142;11177.51590902313;11314.717132071764;11464.025557827677 04:56:32 INFO - PROCESS | 2367 | |3;mootools.html;1285.0554842190993;1472.1387988027004;1506.149025800423;1710.9486715398534;1903.8667293289475;7458.738944136956;7850.882236766446;7989.081255655594;8394.748157555283;8411.03273123591;8206.507609543416;8306.91693083069;8330.875036874451;8340.833183336345;8345.332373410129;1789.6689112514161;2256.131389415079;2311.43369874381;2349.3656712687566;2355.9764402356013;1766.5760217547825;1998.7001949707515;2180.4766855954535;2271.7955384015436;2365.8817059146972;2334.0663734506247;2335.754745751697;2338.4153961509624;2339.8479098858606;2343.8945247463903;2281.6577513372963;2327;2328.522652856169;2332.3586013846157;2333.498297865967;2278.7721227877246;2286.8056215221727;2350.3771500552366;2354.835161538693;2362.9645555316683;7257.52826066304;8492.235698787077;8496.447730897471;8519.318454523685;8519.659213631447;5074.31496747938;5238.214267859851;5245.947540524622;5248.265242865964;5263.763130659091;3279.4588892832653;3448.9310213795834;3526.5944416392185;3528.982355088234;3536.487209354629;974.8642831101758;1051.7107795356262;1054.5412745455674;1678.4796713019002;1728.3173146607019;10621.5220315086;10675.519601617945;10754.300970436974;10761.515731792088;10766.56933722658;3475.8609655614;4225.19721252961;4376.205755640236;4459.576340247671;4465.276181529264;8543.102974187745;8555.443896146731;8565.057843637194;8579.184977427134;8582.485050896841;5090.872728181825;5100.69395836251;5101.591872650179;5107.208382700613;5110.463401342806;4638.165130276582;4780.067886762117;4785.353977213102;4794.760261986887;4795.640326975491;3617.5839778425293;3675.4119340905327;3677.5403074615674;3701.777893326409;3704.388775851954;1150.4190383856098;1159.6636975277245;1165.452237448398;1168.1530890104607;1174.5830230268302;830.0654895793894;838.4927119092982;885.5129678676702;887.7336798960287;930.8976012638605;5341.118715411913;5544.473275038865;5712.685802280831;5755.280589926259;5766.365699773021;715.6099925540593;884.38093334666;917.2111983694151;919.4621146629163;975.0444564326999;3695.90760230991;3708.2768860072565;3775.679067279257;3928.8821335359985;3937.1535119948776;8491.683789012714;9605.18355939753;9729.318947673595;9978.052085051908;10180.440075795754;10019.298649094493;10186.388816671024;10226.335288206243;10250.026247506476;10259.28185027056;7560.168381478033;7833.921660783433;7834.334081603013;7836.804079897935;7853.018372703526;5380.654836290927;5411.675299482044;5441.5102640762525;5696.629719068247;5715.228444159985;9258.907410925805;9402.200812930978;9474.668386606436;9483.245342076263;9571.18644915162;9314.906850931404;9564.4739539326;9570;9594.904050959402;9700.805983880424;6579.868402631825;6831.248562658203;6833.863322733418;7071.080759501232;7275.708971641287;7855.764327070197;7986.8801967971685;8064.153263907206;8066.153053929253;8080.676772929017;7135.571865688075;7185.461090418344;7224.602646854263;7239.601821899846;7250.202477727551;6057.515398768;6288.622682639057;6672.266050734513;7011.824704382431;7187.1734750504365;6356.110144579855;6737.258901520927;6740.797776066725;6743.763968261087;6749.93250067493;4284.592963668447;4331.69678122541;4342.261815491311;4434.646917494441;4469.9776501117285;4117.3618089196225;4236.830526779017;4845.297431872429;4900.926486102782;4932.260160975882 04:56:32 INFO - PROCESS | 2367 | |4;prototype.html;310.54195062283134;332.1894577231555;342.2863329957041;365.5287467941535;375.09227669040916;4958.702477851331;4972.975135124324;5005.149124648809;5007.023630392075;5018.49815018498;4938.876528086799;4940.209566469365;4943.060818444502;4964.528369804862;4969.9811538634585;3377.4089534331515;3445.603755568104;3681.539807524053;3817.675497582709;3825.7948746145016;3260.5272235525836;3881.8835434936855;3889.2027134437512;3913.1391093959282;3917.843286268546;3070.8157510549327;3144.68553144686;3863.43980122882;3885.7279990400684;3907.4529565860803;2899.8260104393803;3392.7116195123444;3536.2614097109995;3690.5940346561993;3814.5803961564206;3024.2137044368624;3295.2915123248617;3301.5212794144954;3396.762226644136;3505.8772942946875;3702.6118153790653;4343.9348409773875;4401.537838526972;4668.789904454307;4763.976180119112;3401.3877502049622;4276.3799249109015;4413.16149931512;4445.222086134913;4483.690899186921;4279.614834664864;4793.32893394925;4882.804687812483;5181.766820493049;5226.771708648503;3052.465818481779;3813.4470501777364;3818.866339678098;3825.387937929918;3826.201685207948;4457.9969506861025;5154.742262886841;5343.5457986071615;5485.204645326406;5487.79268560916;3359.5296658467832;3387.3394688036087;3440.9483857742152;3708.38811596089;3914.5142834300423;3332.4001679697403;3771.6039815819495;3903.6096390360735;3932.6853851691794;3943.3887747398626;3861.8607510784386;3882.3594106972596;4074.959250407517;4410.117976404732;4425.35832304314;4210.400047981748;5020.347354843847;5207.71357575337;5216.869578260498;5250.3962044364625;1077.165196972337;1185.7904936964248;1199.7120691034088;1201.7055821323831;1204.114975493012;688.6591137387026;796.3469954637258;811.350919264586;826.3265438667466;831.3930830493653;3634.60019397866;4177.811998460016;4601.815927362935;4627.3521706961055;4635;4227.450431443954;4597.0465399756185;4682.438107427062;4722.693024953367;4758.408136148633;4314.439122914001;4443.178012067778;4601.861944141681;4603.49361570227;4645;2433.6614861825924;2493.289412517424;2628.7634112929927;2633.9604905926044;2665.8800353984116;4674.924767303539;4688.2733176357715;4858.153901517401;4861.562459378673;5353.625246232727;4867.756612169377;4936.975839905622;5158.871028224325;5180.093483640348;5190.377154741455;5051.772670229775;5217.426083130853;5412.539934105566;5615.4946054854445;5678.602497825278;4471.299093655615;5378.247045413724;5386.542143917811;5391.379991300893;5410.107332290128;4783.1390349737385;5112.795488180431;5309.522143007148;5348.572114230775;5354.919676204782;5357.785688572413;5488.243761996123;5512.877542146222;5535.39110697831;5696.772129114789;3066.846657667063;3637.599864015009;3675.6875665568728;3677.724170687263;3683.2265224302123;4454.532274111171;4718.480967093686;5341.465853414627;5353.357597088374;5382.596305277199;4959.479254678351;5194.246834208943;5231.764570594256;5232.136697444879;5268.157094864803;4181.958180418157;5158.896822063462;5183.429822719422;5187.717404342077;5209.426963033988;4271.914561708811;4794.688345257547;5055.368078990126;5076;5113.41195762492;4079.613426145738;4345.760983145831;4732.929006064981;5116.6418350716585;5272.209168624737;4899.191633380452;5073.086844367902;5104.515071068243;5122.769475373542;5122.846314610568 04:56:32 INFO - PROCESS | 2367 | |5;yui.html;723.8950352198931;732.5824280160307;767.8195624028352;804.428855512586;804.979875503112;14506.564803055911;15541.844581554182;15542.53372398827;15546.678532324751;15608.98541594797;11612.825807612871;13919.652008699788;14096;14103.71792564148;14131.646708832284;689.5896941319907;711.7473296979575;712.4763298975275;857.8670306102564;871.7559083456642;877.7761670773943;883.2007033634571;885.327151364964;887.7336798960318;888.2938064238946;946.7159852044393;949.2216382566298;951.3198063384679;952.3048174832377;954.2795189631853;874.7594411536815;894.2979760887737;926.6108234541508;938.6902322233681;941.9058094190594;534.636447215893;550.9559384965468;559.2003435087822;694.3958755882364;695.3012222716138;12806.807897881446;12868.806967895489;12901.935490322488;12919.935400323033;12936.28850413227;13152.605421837361;13258.337083145901;13284.867151328459;13305.86694133056;13328.333583320893;12191.207571507824;12231.633051008484;12340.938295308555;12401.937990310082;12435.253884766942;4184.205001049791;4212.641925436342;4229.936550951707;4401.977990110061;4441.378207051015;94576;98692.013079869;100062.49968750183;103912;104244.47877760639;9138.268938484905;10398.896011039793;10475.1096156826;10527.157827373792;10923.399213043358;19371.4188574343;20175.293864714666;20476;20843.687344689537;20873.26943556968;7749.690012399554;7837.412194085467;7852.960735196401;7920.564368959647;7968.362530997506;4310.870673879788;4351.6083552479795;4381.978090109529;4444.400005999149;4560.338750881104;3604.7656902301264;3666.7983260920905;3670.3576874046935;3710.165212827146;3715.6098609645596;649.5485637482;651.9250286217051;654.443722835586;664.7573635622963;672.1530871102447;625.612120485293;626.9059641053879;638.5083485716066;661.7915356662636;672.5729161982176;9133.634654613874;9414;9539.61841526345;9572.56923438447;10011.899881001242;517.0408891506277;554.7974989129019;560.403170623285;623.2925629410561;702.8945658151318;3925.4700615417123;3935.4490371348033;3984.7210695251633;4498.280275156025;4545.659075569345;86548;90900.54549727209;91135;92561.0743892566;93775.062249378;78909;79520;80537.59731201307;82154.58922705348;83615.58192209122;74879.25120748831;74898.62550687321;76380;76977;77721.61139194267;8804.911950880409;8810.867836982323;8874.979377371685;8881.511516866634;9078.773030674285;39852.800735996134;46903.53096468992;48384.032319352715;49415.752921235166;50087.248691268935;66927;67764.6611766938;69153;69184.65407672929;69430.65284673544;10650.360978341014;11415.200935934405;11528.82706759416;11540.076793856304;11554.537818487166;12475.5009799607;12668.619941401772;12669.493220271086;12746.808797867854;12893.677658058623;11856.170068095496;11892.286462812259;11921.94039029834;12046.972870487281;12053.096017798525;11976.640700778991;11999.880001199876;12141.69645758863;12223.93888030554;12541.623751287476;11563.132765042486;11816.468258928197;12037.699057523632;12090.879091209326;12448.439820208294;10154.593816247267;10292;10343.482825858828;10376.325538839952;10497.10774584169;9646.42121472714;10244.282900197213;10305;10305.53625086888;10324.122449591869 04:56:32 INFO - PROCESS | 2367 | __end_tp_report 04:56:32 INFO - PROCESS | 2367 | __start_cc_report 04:56:32 INFO - PROCESS | 2367 | _x_x_mozilla_cycle_collect,1808 04:56:32 INFO - PROCESS | 2367 | __end_cc_report 04:56:32 INFO - PROCESS | 2367 | __startTimestamp1482065792392__endTimestamp 04:56:32 INFO - PROCESS | 2367 | 04:56:32 INFO - PROCESS | 2367 | ------- Summary: start ------- 04:56:32 INFO - PROCESS | 2367 | Number of tests: 6 04:56:32 INFO - PROCESS | 2367 | 04:56:32 INFO - PROCESS | 2367 | [#0] dojo.html Cycles:165 Average:5465.67 Median:5606.24 stddev:605.53 (10.8%) stddev-sans-first:580.69 04:56:32 INFO - PROCESS | 2367 | Values: 3198.6 3216.7 3253.0 3253.7 3283.5 5292.6 5386.4 5428.2 5441.4 5493.3 5410.4 5435.7 5514.7 5520.8 5521.5 4959.0 4966.0 4978.4 5018.6 5036.1 5021.7 5114.9 5115.4 5135.3 5193.3 4941.2 5072.1 5087.3 5108.3 5188.3 4973.2 5000.8 5049.1 5055.1 5069.6 4955.8 4985.4 5022.0 5030.3 5061.2 5416.7 5428.9 5442.3 5444.0 5446.7 5675.1 5736.2 5745.8 5769.2 5863.6 5913.5 5921.3 5931.5 5988.7 5999.9 5496.9 5511.6 5517.9 5527.1 5541.2 6059.7 6060.0 6124.8 6141.0 6179.3 4719.4 5618.4 5698.4 5712.6 5717.1 5854.5 5857.8 5859.9 5879.1 5879.3 5708.9 5759.8 5761.7 5775.3 5776.6 5792.3 5792.4 5808.2 5815.5 5818.7 4124.9 4595.4 4684.3 4687.6 4693.9 4150.9 4159.8 4160.9 4170.9 4234.4 5481.7 5482.5 5505.4 5507.8 5557.6 5891.6 5927.7 5945.1 5946.1 5958.7 5395.8 5454.3 5458.0 5480.0 5520.4 5131.6 5172.6 5176.1 5201.0 5225.6 6277.2 6308.3 6320.9 6326.7 6336.1 5429.1 5848.8 5954.6 5972.4 5976.6 6159.8 6195.6 6216.0 6237.3 6246.7 5834.8 5847.1 5850.5 5856.2 5872.0 5857.1 5869.9 5911.3 5920.7 5924.3 5606.2 5656.1 5676.1 5686.9 5750.4 5734.1 5798.9 5800.7 5808.7 5809.6 5618.1 5651.7 5652.2 5661.1 5671.2 5629.0 5705.4 5716.6 5728.2 5774.5 5510.8 5542.4 5569.6 5576.0 5590.4 04:56:32 INFO - PROCESS | 2367 | 04:56:32 INFO - PROCESS | 2367 | [#1] ext.html Cycles:180 Average:54998.12 Median:19228.55 stddev:111962.74 (582.3%) stddev-sans-first:112201.77 04:56:32 INFO - PROCESS | 2367 | Values: 394.9 479.6 487.9 488.5 494.5 30828.7 32152.4 32181.5 32224.7 40866.8 38273.7 40075.0 40342.6 42770.1 42942.1 9343.5 9567.1 9571.2 9583.3 9597.1 8481.1 8684.7 9392.8 9501.3 11180.0 9881.9 11256.5 11291.0 11475.3 11542.8 11380.7 11402.9 11445.7 11488.5 11491.9 8394.0 8613.6 11100.6 11341.3 11400.9 40125.8 40417.4 40481.0 40505.6 40517.0 3339.7 3447.8 3530.3 3548.5 3756.2 28007.7 28739.0 29190.6 29583.9 29607.7 3119.7 3142.9 3182.2 3247.0 3252.6 469264.0 472369.0 473140.6 473673.0 477867.0 55818.4 56175.7 56204.2 56316.4 56395.0 56015.0 56071.4 56196.4 56251.0 56288.4 15162.7 15795.0 15825.7 15834.2 15858.2 12223.4 12351.2 12360.9 12371.4 12372.9 15296.3 15619.9 15654.6 17112.0 17598.0 7370.3 7553.4 7563.3 7576.5 7645.9 866.8 928.4 950.4 982.2 1025.1 29118.9 29404.3 30202.0 30443.0 30787.4 1023.4 1081.2 1091.9 1106.5 1124.7 15024.9 15364.8 15755.6 15777.4 15981.7 183743.0 184182.0 184324.0 184468.0 184787.0 59697.7 60353.0 60386.4 60440.4 60695.4 1392.4 1392.8 1411.5 1418.3 1422.8 29072.6 29612.4 29666.0 30517.7 30552.1 51962.2 52211.5 52439.0 52486.7 52602.5 515089.4 519805.0 519898.0 520668.0 520681.0 26618.0 26846.0 27184.9 27260.3 27284.5 33306.5 39043.8 39514.4 41418.0 47910.5 35964.3 38675.8 39449.4 39670.0 41200.2 38867.8 39025.0 39156.2 40373.0 40603.4 38437.6 38791.6 38926.0 39114.0 39199.2 32910.3 34356.8 34526.8 34916.3 34926.8 25250.4 25401.2 25413.2 25634.7 25718.0 04:56:32 INFO - PROCESS | 2367 | 04:56:32 INFO - PROCESS | 2367 | [#2] jquery.html Cycles:180 Average:33340.08 Median:2024.91 stddev:88328.02 (4362.1%) stddev-sans-first:88541.08 04:56:32 INFO - PROCESS | 2367 | Values: 356.3 367.9 375.9 383.6 406.1 11155.1 11628.7 14062.0 14661.9 19577.4 21089.4 21400.6 22099.9 22281.0 22418.2 6149.2 6649.0 6716.4 6718.9 6734.8 4507.6 4695.7 4756.6 6605.8 6755.2 7583.4 7645.8 7661.5 7670.6 7670.7 7306.2 7517.1 7586.8 7601.7 7639.7 7051.9 7294.1 7317.0 7333.4 7342.3 26672.1 26675.6 27220.5 27578.9 27863.0 2297.7 2373.8 2413.9 2473.4 3225.4 16255.3 16356.9 16584.0 16630.1 17210.8 1855.2 1859.9 1894.9 1996.9 2056.4 124683.0 128109.0 130104.0 130631.3 131385.0 20068.5 21179.2 21182.5 21350.7 21412.3 28133.0 29322.7 31321.1 33017.8 33035.5 8364.4 8529.8 10181.7 10682.3 10851.4 7978.3 8841.7 8855.4 8978.2 8981.6 8801.8 9599.1 9642.8 9716.7 9754.5 3041.4 3620.3 3621.5 3634.2 3681.9 369.9 379.8 403.2 838.4 895.7 11646.2 11671.8 11829.3 12092.0 12102.9 387.7 413.2 418.4 428.7 431.8 4939.4 5951.9 5961.0 6173.0 6183.0 499650.5 503162.0 533800.0 538949.0 552029.0 64082.0 113994.0 127627.4 129049.0 129885.0 432.4 442.9 443.3 446.1 447.4 11203.3 11391.3 11459.3 18161.0 19214.4 53136.0 53658.7 54049.0 54158.7 55499.2 56728.4 69642.0 72741.6 74761.0 76941.6 7909.1 8013.1 8186.3 8224.8 8246.7 12606.8 12731.4 12821.0 12934.2 12950.4 9211.4 10826.7 11000.4 11354.2 11382.0 10214.6 10718.9 10782.6 10883.4 11348.9 11087.8 11267.0 11337.8 11460.7 11631.4 5992.3 7776.4 7991.2 8211.3 8434.2 9332.7 11121.7 11177.5 11314.7 11464.0 04:56:32 INFO - PROCESS | 2367 | 04:56:32 INFO - PROCESS | 2367 | [#3] mootools.html Cycles:180 Average:5370.31 Median:5174.34 stddev:2948.16 (57.0%) stddev-sans-first:2940.44 04:56:32 INFO - PROCESS | 2367 | Values: 1285.1 1472.1 1506.1 1710.9 1903.9 7458.7 7850.9 7989.1 8394.7 8411.0 8206.5 8306.9 8330.9 8340.8 8345.3 1789.7 2256.1 2311.4 2349.4 2356.0 1766.6 1998.7 2180.5 2271.8 2365.9 2334.1 2335.8 2338.4 2339.8 2343.9 2281.7 2327.0 2328.5 2332.4 2333.5 2278.8 2286.8 2350.4 2354.8 2363.0 7257.5 8492.2 8496.4 8519.3 8519.7 5074.3 5238.2 5245.9 5248.3 5263.8 3279.5 3448.9 3526.6 3529.0 3536.5 974.9 1051.7 1054.5 1678.5 1728.3 10621.5 10675.5 10754.3 10761.5 10766.6 3475.9 4225.2 4376.2 4459.6 4465.3 8543.1 8555.4 8565.1 8579.2 8582.5 5090.9 5100.7 5101.6 5107.2 5110.5 4638.2 4780.1 4785.4 4794.8 4795.6 3617.6 3675.4 3677.5 3701.8 3704.4 1150.4 1159.7 1165.5 1168.2 1174.6 830.1 838.5 885.5 887.7 930.9 5341.1 5544.5 5712.7 5755.3 5766.4 715.6 884.4 917.2 919.5 975.0 3695.9 3708.3 3775.7 3928.9 3937.2 8491.7 9605.2 9729.3 9978.1 10180.4 10019.3 10186.4 10226.3 10250.0 10259.3 7560.2 7833.9 7834.3 7836.8 7853.0 5380.7 5411.7 5441.5 5696.6 5715.2 9258.9 9402.2 9474.7 9483.2 9571.2 9314.9 9564.5 9570.0 9594.9 9700.8 6579.9 6831.2 6833.9 7071.1 7275.7 7855.8 7986.9 8064.2 8066.2 8080.7 7135.6 7185.5 7224.6 7239.6 7250.2 6057.5 6288.6 6672.3 7011.8 7187.2 6356.1 6737.3 6740.8 6743.8 6749.9 4284.6 4331.7 4342.3 4434.6 4470.0 4117.4 4236.8 4845.3 4900.9 4932.3 04:56:32 INFO - PROCESS | 2367 | 04:56:32 INFO - PROCESS | 2367 | [#4] prototype.html Cycles:180 Average:4151.03 Median:4615.42 stddev:1272.63 (27.6%) stddev-sans-first:1243.13 04:56:32 INFO - PROCESS | 2367 | Values: 310.5 332.2 342.3 365.5 375.1 4958.7 4973.0 5005.1 5007.0 5018.5 4938.9 4940.2 4943.1 4964.5 4970.0 3377.4 3445.6 3681.5 3817.7 3825.8 3260.5 3881.9 3889.2 3913.1 3917.8 3070.8 3144.7 3863.4 3885.7 3907.5 2899.8 3392.7 3536.3 3690.6 3814.6 3024.2 3295.3 3301.5 3396.8 3505.9 3702.6 4343.9 4401.5 4668.8 4764.0 3401.4 4276.4 4413.2 4445.2 4483.7 4279.6 4793.3 4882.8 5181.8 5226.8 3052.5 3813.4 3818.9 3825.4 3826.2 4458.0 5154.7 5343.5 5485.2 5487.8 3359.5 3387.3 3440.9 3708.4 3914.5 3332.4 3771.6 3903.6 3932.7 3943.4 3861.9 3882.4 4075.0 4410.1 4425.4 4210.4 5020.3 5207.7 5216.9 5250.4 1077.2 1185.8 1199.7 1201.7 1204.1 688.7 796.3 811.4 826.3 831.4 3634.6 4177.8 4601.8 4627.4 4635.0 4227.5 4597.0 4682.4 4722.7 4758.4 4314.4 4443.2 4601.9 4603.5 4645.0 2433.7 2493.3 2628.8 2634.0 2665.9 4674.9 4688.3 4858.2 4861.6 5353.6 4867.8 4937.0 5158.9 5180.1 5190.4 5051.8 5217.4 5412.5 5615.5 5678.6 4471.3 5378.2 5386.5 5391.4 5410.1 4783.1 5112.8 5309.5 5348.6 5354.9 5357.8 5488.2 5512.9 5535.4 5696.8 3066.8 3637.6 3675.7 3677.7 3683.2 4454.5 4718.5 5341.5 5353.4 5382.6 4959.5 5194.2 5231.8 5232.1 5268.2 4182.0 5158.9 5183.4 5187.7 5209.4 4271.9 4794.7 5055.4 5076.0 5113.4 4079.6 4345.8 4732.9 5116.6 5272.2 4899.2 5073.1 5104.5 5122.8 5122.8 04:56:32 INFO - PROCESS | 2367 | 04:56:32 INFO - PROCESS | 2367 | [#5] yui.html Cycles:180 Average:19226.07 Median:4521.97 stddev:27458.88 (607.2%) stddev-sans-first:27500.76 04:56:32 INFO - PROCESS | 2367 | Values: 723.9 732.6 767.8 804.4 805.0 14506.6 15541.8 15542.5 15546.7 15609.0 11612.8 13919.7 14096.0 14103.7 14131.6 689.6 711.7 712.5 857.9 871.8 877.8 883.2 885.3 887.7 888.3 946.7 949.2 951.3 952.3 954.3 874.8 894.3 926.6 938.7 941.9 534.6 551.0 559.2 694.4 695.3 12806.8 12868.8 12901.9 12919.9 12936.3 13152.6 13258.3 13284.9 13305.9 13328.3 12191.2 12231.6 12340.9 12401.9 12435.3 4184.2 4212.6 4229.9 4402.0 4441.4 94576.0 98692.0 100062.5 103912.0 104244.5 9138.3 10398.9 10475.1 10527.2 10923.4 19371.4 20175.3 20476.0 20843.7 20873.3 7749.7 7837.4 7853.0 7920.6 7968.4 4310.9 4351.6 4382.0 4444.4 4560.3 3604.8 3666.8 3670.4 3710.2 3715.6 649.5 651.9 654.4 664.8 672.2 625.6 626.9 638.5 661.8 672.6 9133.6 9414.0 9539.6 9572.6 10011.9 517.0 554.8 560.4 623.3 702.9 3925.5 3935.4 3984.7 4498.3 4545.7 86548.0 90900.5 91135.0 92561.1 93775.1 78909.0 79520.0 80537.6 82154.6 83615.6 74879.3 74898.6 76380.0 76977.0 77721.6 8804.9 8810.9 8875.0 8881.5 9078.8 39852.8 46903.5 48384.0 49415.8 50087.2 66927.0 67764.7 69153.0 69184.7 69430.7 10650.4 11415.2 11528.8 11540.1 11554.5 12475.5 12668.6 12669.5 12746.8 12893.7 11856.2 11892.3 11921.9 12047.0 12053.1 11976.6 11999.9 12141.7 12223.9 12541.6 11563.1 11816.5 12037.7 12090.9 12448.4 10154.6 10292.0 10343.5 10376.3 10497.1 9646.4 10244.3 10305.0 10305.5 10324.1 04:56:32 INFO - PROCESS | 2367 | -------- Summary: end -------- 04:56:32 INFO - PROCESS | 2367 | 04:56:33 INFO - TEST-INFO | 2367: exit 0 04:56:33 INFO - TEST-OK | dromaeo_css | took 1121595ms 04:56:33 INFO - TEST-START | kraken 04:56:33 INFO - operating with platform_type : mac_ 04:56:33 INFO - Initialising browser for kraken test... 04:56:33 INFO - TEST-INFO | started process 2371 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpPVFaAF/profile http://localhost:53190/getInfo.html) 04:56:35 INFO - PROCESS | 2371 | __metrics Screen width/height:1600/1200 04:56:35 INFO - PROCESS | 2371 | colorDepth:24 04:56:35 INFO - PROCESS | 2371 | Browser inner width/height: 1024/689 04:56:35 INFO - PROCESS | 2371 | __metrics 04:56:35 INFO - PROCESS | 2371 | 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" 04:56:35 INFO - PROCESS | 2371 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:36 INFO - TEST-INFO | 2371: exit 0 04:56:36 INFO - Browser initialized. 04:56:36 INFO - Running cycle 1/1 for kraken test... 04:56:36 INFO - TEST-INFO | started process 2373 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/tmpPVFaAF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:48 INFO - PROCESS | 2373 | RSS: Main: 236949504 04:56:48 INFO - PROCESS | 2373 | 04:56:51 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53190/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:51 INFO - PROCESS | 2373 | RSS: Main: 288849920 04:56:51 INFO - PROCESS | 2373 | 04:56:54 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53190/tests/kraken/driver.html?testName=audio-dft) 04:56:55 INFO - PROCESS | 2373 | RSS: Main: 290111488 04:56:55 INFO - PROCESS | 2373 | 04:56:58 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53190/tests/kraken/driver.html?testName=audio-fft) 04:56:59 INFO - PROCESS | 2373 | RSS: Main: 380088320 04:56:59 INFO - PROCESS | 2373 | 04:57:01 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53190/tests/kraken/driver.html?testName=audio-oscillator) 04:57:01 INFO - PROCESS | 2373 | RSS: Main: 282349568 04:57:01 INFO - PROCESS | 2373 | 04:57:03 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53190/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:57:04 INFO - PROCESS | 2373 | RSS: Main: 286785536 04:57:04 INFO - PROCESS | 2373 | 04:57:07 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53190/tests/kraken/driver.html?testName=imaging-darkroom) 04:57:08 INFO - PROCESS | 2373 | RSS: Main: 329310208 04:57:08 INFO - PROCESS | 2373 | 04:57:11 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53190/tests/kraken/driver.html?testName=imaging-desaturate) 04:57:11 INFO - PROCESS | 2373 | RSS: Main: 332124160 04:57:11 INFO - PROCESS | 2373 | 04:57:14 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53190/tests/kraken/driver.html?testName=json-parse-financial) 04:57:15 INFO - PROCESS | 2373 | RSS: Main: 328073216 04:57:15 INFO - PROCESS | 2373 | 04:57:16 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53190/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:57:17 INFO - PROCESS | 2373 | RSS: Main: 305463296 04:57:17 INFO - PROCESS | 2373 | 04:57:19 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53190/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:57:19 INFO - PROCESS | 2373 | RSS: Main: 306601984 04:57:19 INFO - PROCESS | 2373 | 04:57:22 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53190/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:57:22 INFO - PROCESS | 2373 | RSS: Main: 310050816 04:57:22 INFO - PROCESS | 2373 | 04:57:25 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:57:26 INFO - PROCESS | 2373 | RSS: Main: 324968448 04:57:26 INFO - PROCESS | 2373 | 04:57:29 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:57:30 INFO - PROCESS | 2373 | RSS: Main: 318779392 04:57:30 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | Cycle 1(1): loaded http://localhost:53190/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53190/tests/kraken/driver.html?testName=ai-astar) 04:57:32 INFO - PROCESS | 2373 | RSS: Main: 363085824 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | __start_tp_report 04:57:32 INFO - PROCESS | 2373 | _x_x_mozilla_page_load 04:57:32 INFO - PROCESS | 2373 | _x_x_mozilla_page_load_details 04:57:32 INFO - PROCESS | 2373 | |i|pagename|runs| 04:57:32 INFO - PROCESS | 2373 | |0;ai-astar;113;111;113;113;113;114;113;114;110;113 04:57:32 INFO - PROCESS | 2373 | |1;audio-beat-detection;143;121;109;148;111;111;111;110;130;116 04:57:32 INFO - PROCESS | 2373 | |2;audio-dft;187;183;184;186;184;186;186;179;182;185 04:57:32 INFO - PROCESS | 2373 | |3;audio-fft;83;60;59;87;62;59;58;59;75;59 04:57:32 INFO - PROCESS | 2373 | |4;audio-oscillator;87;71;86;70;69;68;84;69;69;84 04:57:32 INFO - PROCESS | 2373 | |5;imaging-gaussian-blur;110;111;115;171;118;112;109;112;108;110 04:57:32 INFO - PROCESS | 2373 | |6;imaging-darkroom;96;96;97;97;96;97;97;96;96;96 04:57:32 INFO - PROCESS | 2373 | |7;imaging-desaturate;85;87;82;84;84;85;85;84;85;91 04:57:32 INFO - PROCESS | 2373 | |8;json-parse-financial;56;56;55;55;55;58;56;54;55;53 04:57:32 INFO - PROCESS | 2373 | |9;json-stringify-tinderbox;65;71;83;73;72;71;70;73;69;68 04:57:32 INFO - PROCESS | 2373 | |10;stanford-crypto-aes;99;99;109;107;88;90;86;89;90;89 04:57:32 INFO - PROCESS | 2373 | |11;stanford-crypto-ccm;139;140;140;138;140;137;152;143;212;174 04:57:32 INFO - PROCESS | 2373 | |12;stanford-crypto-pbkdf2;174;168;179;171;169;170;186;207;172;166 04:57:32 INFO - PROCESS | 2373 | |13;stanford-crypto-sha256-iterative;67;67;68;66;67;67;66;66;68;66 04:57:32 INFO - PROCESS | 2373 | __end_tp_report 04:57:32 INFO - PROCESS | 2373 | __start_cc_report 04:57:32 INFO - PROCESS | 2373 | _x_x_mozilla_cycle_collect,2104 04:57:32 INFO - PROCESS | 2373 | __end_cc_report 04:57:32 INFO - PROCESS | 2373 | __startTimestamp1482065852321__endTimestamp 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | ------- Summary: start ------- 04:57:32 INFO - PROCESS | 2373 | Number of tests: 14 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#0] ai-astar Cycles:10 Average:112.70 Median:113.00 stddev:1.25 (1.1%) stddev-sans-first:1.32 04:57:32 INFO - PROCESS | 2373 | Values: 113.0 111.0 113.0 113.0 113.0 114.0 113.0 114.0 110.0 113.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#1] audio-beat-detection Cycles:10 Average:121.00 Median:118.50 stddev:14.47 (12.2%) stddev-sans-first:12.97 04:57:32 INFO - PROCESS | 2373 | Values: 143.0 121.0 109.0 148.0 111.0 111.0 111.0 110.0 130.0 116.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#2] audio-dft Cycles:10 Average:184.20 Median:185.50 stddev:2.39 (1.3%) stddev-sans-first:2.32 04:57:32 INFO - PROCESS | 2373 | Values: 187.0 183.0 184.0 186.0 184.0 186.0 186.0 179.0 182.0 185.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.00 stddev:11.17 (18.3%) stddev-sans-first:10.03 04:57:32 INFO - PROCESS | 2373 | Values: 83.0 60.0 59.0 87.0 62.0 59.0 58.0 59.0 75.0 59.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:77.50 stddev:8.30 (10.7%) stddev-sans-first:7.73 04:57:32 INFO - PROCESS | 2373 | Values: 87.0 71.0 86.0 70.0 69.0 68.0 84.0 69.0 69.0 84.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:112.00 stddev:18.99 (17.0%) stddev-sans-first:19.94 04:57:32 INFO - PROCESS | 2373 | Values: 110.0 111.0 115.0 171.0 118.0 112.0 109.0 112.0 108.0 110.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:57:32 INFO - PROCESS | 2373 | Values: 96.0 96.0 97.0 97.0 96.0 97.0 97.0 96.0 96.0 96.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.00 stddev:2.39 (2.8%) stddev-sans-first:2.54 04:57:32 INFO - PROCESS | 2373 | Values: 85.0 87.0 82.0 84.0 84.0 85.0 85.0 84.0 85.0 91.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.50 stddev:1.34 (2.4%) stddev-sans-first:1.39 04:57:32 INFO - PROCESS | 2373 | Values: 56.0 56.0 55.0 55.0 55.0 58.0 56.0 54.0 55.0 53.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:71.50 stddev:4.72 (6.6%) stddev-sans-first:4.38 04:57:32 INFO - PROCESS | 2373 | Values: 65.0 71.0 83.0 73.0 72.0 71.0 70.0 73.0 69.0 68.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:89.50 stddev:8.32 (9.3%) stddev-sans-first:8.67 04:57:32 INFO - PROCESS | 2373 | Values: 99.0 99.0 109.0 107.0 88.0 90.0 86.0 89.0 90.0 89.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#11] stanford-crypto-ccm Cycles:10 Average:151.50 Median:141.50 stddev:24.00 (17.0%) stddev-sans-first:25.03 04:57:32 INFO - PROCESS | 2373 | Values: 139.0 140.0 140.0 138.0 140.0 137.0 152.0 143.0 212.0 174.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.20 Median:173.00 stddev:12.31 (7.1%) stddev-sans-first:13.03 04:57:32 INFO - PROCESS | 2373 | Values: 174.0 168.0 179.0 171.0 169.0 170.0 186.0 207.0 172.0 166.0 04:57:32 INFO - PROCESS | 2373 | 04:57:32 INFO - PROCESS | 2373 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 04:57:32 INFO - PROCESS | 2373 | Values: 67.0 67.0 68.0 66.0 67.0 67.0 66.0 66.0 68.0 66.0 04:57:32 INFO - PROCESS | 2373 | -------- Summary: end -------- 04:57:32 INFO - PROCESS | 2373 | 04:57:33 INFO - TEST-INFO | 2373: exit 0 04:57:33 INFO - TEST-OK | kraken | took 60201ms 04:57:33 INFO - SUITE-END | took 1181s 04:57:33 INFO - Completed test suite (00:19:42) 04:57:33 INFO - javascript benchmark 04:57:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3198.648148703642, 3216.6972376187646, 3252.983735081326, 3253.7234335081516, 3283.491058885872, 5292.550133238669, 5386.380566234884, 5428.185772134182, 5441.401445840959, 5493.340799104109, 5410.404855465906, 5435.673859568428, 5514.724263786805, 5520.806771762989, 5521.503064724174, 4958.975205123969, 4965.975170124162, 4978.352814134158, 5018.573421259197, 5036.143855544567, 5021.698698078127, 5114.948850511503, 5115.360579927509, 5135.332406787131, 5193.298904647881, 4941.160002799496, 5072.0870243356185, 5087.287779710843, 5108.310378098946, 5188.273641690166, 4973.154563724175, 5000.799968001275, 5049.1164046292115, 5055.115354812893, 5069.645124841262, 4955.82654607087, 4985.426675932278, 5022.0, 5030.346055012861, 5061.16490779021, 5416.702081385522, 5428.891422171574, 5442.292501974757, 5444.0, 5446.673199608036, 5675.148727690838, 5736.196932429463, 5745.798897038583, 5769.24999750034, 5863.648181109147, 5913.526917846562, 5921.259842519685, 5931.4661680448535, 5988.730507127189, 5999.850003749898, 5496.917546236809, 5511.559075273968, 5517.917231241535, 5527.115661494142, 5541.196526503675, 6059.7273122709585, 6060.0, 6124.846878828065, 6140.969295153495, 6179.2584889812615, 4719.4100737407825, 5618.410066942994, 5698.401667824902, 5712.6286791358425, 5717.085266357363, 5854.531637468992, 5857.7656893724625, 5859.882802344015, 5879.059350503899, 5879.2944846618675, 5708.914366284509, 5759.798407055733, 5761.740721667535, 5775.27809023872, 5776.624519406225, 5792.304923409218, 5792.420757924258, 5808.215890854765, 5815.534757219497, 5818.650880947157, 4124.855630052994, 4595.4025976622825, 4684.320773487825, 4687.62499000086, 4693.882652933704, 4150.875473735793, 4159.812808423628, 4160.875173744793, 4170.937435938464, 4234.428352172417, 5481.725913704299, 5482.451754824566, 5505.394406615269, 5507.807226747044, 5557.6109672323355, 5891.558133139946, 5927.703614819242, 5945.137954996501, 5946.13781001761, 5958.6722730249385, 5395.81114660985, 5454.318210223722, 5457.972710136424, 5480.0, 5520.392756796749, 5131.589472842164, 5172.637915345889, 5176.145935920531, 5200.959808038408, 5225.555827754683, 6277.1525844010475, 6308.3060863305, 6320.905186422299, 6326.746930122744, 6336.081268216083, 5429.131338985743, 5848.824535263949, 5954.553408494294, 5972.432618901197, 5976.611520251344, 6159.753609855556, 6195.597286176384, 6216.0, 6237.251529816451, 6246.718897649525, 5834.766609335748, 5847.1229315603, 5850.473457388855, 5856.209411729362, 5871.970640146943, 5857.092150716646, 5869.882602347844, 5911.290645122613, 5920.674362910081, 5924.318703348998, 5606.24315717373, 5656.1233008882045, 5676.063449530781, 5686.886262274648, 5750.396208398058, 5734.139879018014, 5798.913016304675, 5800.738966746591, 5808.651480911159, 5809.5933284671355, 5618.101103823368, 5651.689157096399, 5652.236948011966, 5661.094224923992, 5671.234383358359, 5628.971855140698, 5705.37240903492, 5716.571257155813, 5728.198052272602, 5774.48029677331, 5510.779568817203, 5542.3903370630005, 5569.582281328835, 5575.968445837533, 5590.385057643574], "value": 5427.1160816883075, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.93286141355975, 479.55401476626764, 487.93656824612793, 488.45049319515545, 494.47585559307134, 30828.69171308289, 32152.35695286093, 32181.51727724086, 32224.67775322249, 40866.773996780146, 38273.66042188524, 40075.0, 40342.59657403425, 42770.14459710804, 42942.14115717684, 9343.532823358822, 9567.138957493824, 9571.18644915183, 9583.28125390595, 9597.136257736802, 8481.109483504204, 8684.739457816275, 9392.7651808705, 9501.334906556544, 11180.0, 9881.901180988207, 11256.493457794419, 11291.0, 11475.254108482923, 11542.826857597143, 11380.658580242605, 11402.94298528502, 11445.713857153554, 11488.483018264198, 11491.885081149165, 8393.958030209871, 8613.569321533962, 11100.55597776088, 11341.319520828776, 11400.94299528497, 40125.799371002955, 40417.39373909364, 40481.0, 40505.59494405048, 40517.0, 3339.7328213742844, 3447.775894566845, 3530.276293359855, 3548.4854696069183, 3756.2487502499607, 28007.719922800716, 28739.0, 29190.562141567894, 29583.85208073946, 29607.703922960925, 3119.7036281553214, 3142.8899988500293, 3182.220356012792, 3246.951295730566, 3252.560904277916, 469264.0, 472369.0, 473140.63429682975, 473673.0, 477867.0, 55818.441815581325, 56175.71912140413, 56204.15693764597, 56316.43683563194, 56395.0, 56015.0, 56071.43928560744, 56196.43803561994, 56251.0, 56288.437115628316, 15162.696746065238, 15794.973326733725, 15825.683486330208, 15834.208289585706, 15858.224810658088, 12223.449944752507, 12351.19717218378, 12360.94931930778, 12371.40200557893, 12372.876271237352, 15296.311665975058, 15619.906606537434, 15654.608634784221, 17112.005399055117, 17598.0, 7370.336669699753, 7553.395728341719, 7563.336066065457, 7576.507527010726, 7645.923540764521, 866.787637028932, 928.3965422475445, 950.3632566180676, 982.1651596143364, 1025.0518270599666, 29118.854405727834, 29404.264893377407, 30202.0, 30443.0, 30787.384252315278, 1023.4217667018111, 1081.2107161771794, 1091.912646988239, 1106.4578356605205, 1124.6569796212234, 15024.924875375553, 15364.846351536342, 15755.606109847116, 15777.447789327318, 15981.671619835028, 183743.0, 184182.0, 184324.0, 184468.0, 184787.0, 59697.70151149217, 60353.0, 60386.39613603808, 60440.395596044356, 60695.39304606897, 1392.4291040673274, 1392.7562676531566, 1411.470698488067, 1418.3475601223347, 1422.8008078868759, 29072.563911541765, 29612.407751845272, 29666.0, 30517.694823051486, 30552.08343749691, 51962.22056669229, 52211.47788522066, 52439.0, 52486.737566311924, 52602.47397526129, 515089.4245528748, 519805.0, 519898.0, 520668.0, 520681.0, 26618.0, 26846.0, 27184.864075679496, 27260.31849203786, 27284.454310913272, 33306.500402494465, 39043.82868513949, 39514.40728389019, 41418.0, 47910.520894792004, 35964.28071438609, 38675.806620966716, 39449.40825887671, 39670.0, 41200.1759964805, 38867.80566097151, 39025.024374390865, 39156.216875662896, 40373.0, 40603.390949135195, 38437.615623843405, 38791.6120838788, 38926.0, 39114.0, 39199.216015678954, 32910.34179316353, 34356.845643953704, 34526.82736586301, 34916.30167396587, 34926.82536587402, 25250.36874078163, 25401.237962861145, 25413.237602871945, 25634.743652563237, 25718.0], "value": 19068.18907596694, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.2998707539684, 367.9392900171472, 375.93233218020765, 383.6163836163837, 406.1248010537293, 11155.05182059526, 11628.709282267926, 14062.0, 14661.926690366547, 19577.412677619657, 21089.367318980454, 21400.57198856022, 22099.889500552476, 22281.0, 22418.215362462317, 6149.231346081729, 6649.00264960255, 6716.429103526206, 6718.865622687544, 6734.764283250087, 4507.639388848901, 4695.71825690458, 4756.571908528232, 6605.801825945229, 6755.1893772747335, 7583.355414789722, 7645.808854778619, 7661.502002369856, 7670.578118203496, 7670.654820533089, 7306.159791623978, 7517.060367454068, 7586.8482630347635, 7601.733939312153, 7639.656215470317, 7051.929480705178, 7294.1247050354295, 7316.963415182943, 7333.376662983653, 7342.339189472919, 26672.06647767319, 26675.599866002027, 27220.455590888072, 27578.89684412621, 27863.0, 2297.7245402324556, 2373.8219633527556, 2413.879306034709, 2473.418746594549, 3225.435663703102, 16255.26851291683, 16356.918215408847, 16584.0, 16630.085345306004, 17210.82789172105, 1855.1651756709534, 1859.8605104617072, 1894.9242030318771, 1996.920123195085, 2056.4036429435446, 124683.0, 128109.0, 130104.0, 130631.34684326613, 131385.0, 20068.498287542636, 21179.163709427612, 21182.47043823917, 21350.679739803916, 21412.25057122993, 28133.0, 29322.706772932423, 31321.06036818899, 33017.834910825295, 33035.504467433006, 8364.414490985695, 8529.829403411897, 10181.74545636365, 10682.288077188121, 10851.364792794344, 7978.3218426434405, 8841.69054083104, 8855.38012339143, 8978.191962723386, 8981.640734370683, 8801.779955501035, 9599.088086631758, 9642.807143857084, 9716.708498745049, 9754.512274386252, 3041.422129795332, 3620.330238905811, 3621.511096002006, 3634.2186429917697, 3681.8895433136513, 369.9334119858451, 379.75316044570695, 403.1614242375851, 838.379599096664, 895.6999405199201, 11646.24299420535, 11671.76656466883, 11829.290242585472, 12092.0, 12102.939485302517, 387.73827666325116, 413.1530362756337, 418.37870761918526, 428.7041941060658, 431.764688244901, 4939.382577177853, 5951.851203719855, 5960.956832554286, 6173.0, 6183.041628547582, 499650.5017474962, 503162.0, 533800.0, 538949.0, 552029.0, 64082.0, 113994.0, 127627.36186319009, 129049.0, 129885.0, 432.3968064549998, 442.8627125591077, 443.33057083803686, 446.08552467442263, 447.44293354773515, 11203.327800332007, 11391.259568128045, 11459.31244125355, 18161.0, 19214.423567293004, 53136.0, 53658.658533536975, 54049.0, 54158.72920635529, 55499.22503874871, 56728.432715672316, 69642.0, 72741.6362918182, 74761.0, 76941.61529192318, 7909.05091389037, 8013.118556958613, 8186.2632363087605, 8224.794380140305, 8246.711365102192, 12606.810897836724, 12731.37155910561, 12821.0, 12934.223946562859, 12950.352482376033, 9211.355205135576, 10826.729331766768, 11000.394978276272, 11354.205205635526, 11382.0, 10214.642487512901, 10718.946405267923, 10782.622608208674, 10883.401412922365, 11348.943255283672, 11087.778244435227, 11267.042301404472, 11337.773244534897, 11460.713482162679, 11631.418429078682, 5992.310884248367, 7776.377889768918, 7991.24083212094, 8211.343092552463, 8434.240918317135, 9332.673356432764, 11121.721956951142, 11177.51590902313, 11314.717132071764, 11464.025557827677], "value": 9630.906670867995, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1285.0554842190993, 1472.1387988027004, 1506.149025800423, 1710.9486715398534, 1903.8667293289475, 7458.738944136956, 7850.882236766446, 7989.081255655594, 8394.748157555283, 8411.03273123591, 8206.507609543416, 8306.91693083069, 8330.875036874451, 8340.833183336345, 8345.332373410129, 1789.6689112514161, 2256.131389415079, 2311.43369874381, 2349.3656712687566, 2355.9764402356013, 1766.5760217547825, 1998.7001949707515, 2180.4766855954535, 2271.7955384015436, 2365.8817059146972, 2334.0663734506247, 2335.754745751697, 2338.4153961509624, 2339.8479098858606, 2343.8945247463903, 2281.6577513372963, 2327.0, 2328.522652856169, 2332.3586013846157, 2333.498297865967, 2278.7721227877246, 2286.8056215221727, 2350.3771500552366, 2354.835161538693, 2362.9645555316683, 7257.52826066304, 8492.235698787077, 8496.447730897471, 8519.318454523685, 8519.659213631447, 5074.31496747938, 5238.214267859851, 5245.947540524622, 5248.265242865964, 5263.763130659091, 3279.4588892832653, 3448.9310213795834, 3526.5944416392185, 3528.982355088234, 3536.487209354629, 974.8642831101758, 1051.7107795356262, 1054.5412745455674, 1678.4796713019002, 1728.3173146607019, 10621.5220315086, 10675.519601617945, 10754.300970436974, 10761.515731792088, 10766.56933722658, 3475.8609655614, 4225.19721252961, 4376.205755640236, 4459.576340247671, 4465.276181529264, 8543.102974187745, 8555.443896146731, 8565.057843637194, 8579.184977427134, 8582.485050896841, 5090.872728181825, 5100.69395836251, 5101.591872650179, 5107.208382700613, 5110.463401342806, 4638.165130276582, 4780.067886762117, 4785.353977213102, 4794.760261986887, 4795.640326975491, 3617.5839778425293, 3675.4119340905327, 3677.5403074615674, 3701.777893326409, 3704.388775851954, 1150.4190383856098, 1159.6636975277245, 1165.452237448398, 1168.1530890104607, 1174.5830230268302, 830.0654895793894, 838.4927119092982, 885.5129678676702, 887.7336798960287, 930.8976012638605, 5341.118715411913, 5544.473275038865, 5712.685802280831, 5755.280589926259, 5766.365699773021, 715.6099925540593, 884.38093334666, 917.2111983694151, 919.4621146629163, 975.0444564326999, 3695.90760230991, 3708.2768860072565, 3775.679067279257, 3928.8821335359985, 3937.1535119948776, 8491.683789012714, 9605.18355939753, 9729.318947673595, 9978.052085051908, 10180.440075795754, 10019.298649094493, 10186.388816671024, 10226.335288206243, 10250.026247506476, 10259.28185027056, 7560.168381478033, 7833.921660783433, 7834.334081603013, 7836.804079897935, 7853.018372703526, 5380.654836290927, 5411.675299482044, 5441.5102640762525, 5696.629719068247, 5715.228444159985, 9258.907410925805, 9402.200812930978, 9474.668386606436, 9483.245342076263, 9571.18644915162, 9314.906850931404, 9564.4739539326, 9570.0, 9594.904050959402, 9700.805983880424, 6579.868402631825, 6831.248562658203, 6833.863322733418, 7071.080759501232, 7275.708971641287, 7855.764327070197, 7986.8801967971685, 8064.153263907206, 8066.153053929253, 8080.676772929017, 7135.571865688075, 7185.461090418344, 7224.602646854263, 7239.601821899846, 7250.202477727551, 6057.515398768, 6288.622682639057, 6672.266050734513, 7011.824704382431, 7187.1734750504365, 6356.110144579855, 6737.258901520927, 6740.797776066725, 6743.763968261087, 6749.93250067493, 4284.592963668447, 4331.69678122541, 4342.261815491311, 4434.646917494441, 4469.9776501117285, 4117.3618089196225, 4236.830526779017, 4845.297431872429, 4900.926486102782, 4932.260160975882], "value": 4362.993241284221, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.54195062283134, 332.1894577231555, 342.2863329957041, 365.5287467941535, 375.09227669040916, 4958.702477851331, 4972.975135124324, 5005.149124648809, 5007.023630392075, 5018.49815018498, 4938.876528086799, 4940.209566469365, 4943.060818444502, 4964.528369804862, 4969.9811538634585, 3377.4089534331515, 3445.603755568104, 3681.539807524053, 3817.675497582709, 3825.7948746145016, 3260.5272235525836, 3881.8835434936855, 3889.2027134437512, 3913.1391093959282, 3917.843286268546, 3070.8157510549327, 3144.68553144686, 3863.43980122882, 3885.7279990400684, 3907.4529565860803, 2899.8260104393803, 3392.7116195123444, 3536.2614097109995, 3690.5940346561993, 3814.5803961564206, 3024.2137044368624, 3295.2915123248617, 3301.5212794144954, 3396.762226644136, 3505.8772942946875, 3702.6118153790653, 4343.9348409773875, 4401.537838526972, 4668.789904454307, 4763.976180119112, 3401.3877502049622, 4276.3799249109015, 4413.16149931512, 4445.222086134913, 4483.690899186921, 4279.614834664864, 4793.32893394925, 4882.804687812483, 5181.766820493049, 5226.771708648503, 3052.465818481779, 3813.4470501777364, 3818.866339678098, 3825.387937929918, 3826.201685207948, 4457.9969506861025, 5154.742262886841, 5343.5457986071615, 5485.204645326406, 5487.79268560916, 3359.5296658467832, 3387.3394688036087, 3440.9483857742152, 3708.38811596089, 3914.5142834300423, 3332.4001679697403, 3771.6039815819495, 3903.6096390360735, 3932.6853851691794, 3943.3887747398626, 3861.8607510784386, 3882.3594106972596, 4074.959250407517, 4410.117976404732, 4425.35832304314, 4210.400047981748, 5020.347354843847, 5207.71357575337, 5216.869578260498, 5250.3962044364625, 1077.165196972337, 1185.7904936964248, 1199.7120691034088, 1201.7055821323831, 1204.114975493012, 688.6591137387026, 796.3469954637258, 811.350919264586, 826.3265438667466, 831.3930830493653, 3634.60019397866, 4177.811998460016, 4601.815927362935, 4627.3521706961055, 4635.0, 4227.450431443954, 4597.0465399756185, 4682.438107427062, 4722.693024953367, 4758.408136148633, 4314.439122914001, 4443.178012067778, 4601.861944141681, 4603.49361570227, 4645.0, 2433.6614861825924, 2493.289412517424, 2628.7634112929927, 2633.9604905926044, 2665.8800353984116, 4674.924767303539, 4688.2733176357715, 4858.153901517401, 4861.562459378673, 5353.625246232727, 4867.756612169377, 4936.975839905622, 5158.871028224325, 5180.093483640348, 5190.377154741455, 5051.772670229775, 5217.426083130853, 5412.539934105566, 5615.4946054854445, 5678.602497825278, 4471.299093655615, 5378.247045413724, 5386.542143917811, 5391.379991300893, 5410.107332290128, 4783.1390349737385, 5112.795488180431, 5309.522143007148, 5348.572114230775, 5354.919676204782, 5357.785688572413, 5488.243761996123, 5512.877542146222, 5535.39110697831, 5696.772129114789, 3066.846657667063, 3637.599864015009, 3675.6875665568728, 3677.724170687263, 3683.2265224302123, 4454.532274111171, 4718.480967093686, 5341.465853414627, 5353.357597088374, 5382.596305277199, 4959.479254678351, 5194.246834208943, 5231.764570594256, 5232.136697444879, 5268.157094864803, 4181.958180418157, 5158.896822063462, 5183.429822719422, 5187.717404342077, 5209.426963033988, 4271.914561708811, 4794.688345257547, 5055.368078990126, 5076.0, 5113.41195762492, 4079.613426145738, 4345.760983145831, 4732.929006064981, 5116.6418350716585, 5272.209168624737, 4899.191633380452, 5073.086844367902, 5104.515071068243, 5122.769475373542, 5122.846314610568], "value": 3762.1462431654536, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.8950352198931, 732.5824280160307, 767.8195624028352, 804.428855512586, 804.979875503112, 14506.564803055911, 15541.844581554182, 15542.53372398827, 15546.678532324751, 15608.98541594797, 11612.825807612871, 13919.652008699788, 14096.0, 14103.71792564148, 14131.646708832284, 689.5896941319907, 711.7473296979575, 712.4763298975275, 857.8670306102564, 871.7559083456642, 877.7761670773943, 883.2007033634571, 885.327151364964, 887.7336798960318, 888.2938064238946, 946.7159852044393, 949.2216382566298, 951.3198063384679, 952.3048174832377, 954.2795189631853, 874.7594411536815, 894.2979760887737, 926.6108234541508, 938.6902322233681, 941.9058094190594, 534.636447215893, 550.9559384965468, 559.2003435087822, 694.3958755882364, 695.3012222716138, 12806.807897881446, 12868.806967895489, 12901.935490322488, 12919.935400323033, 12936.28850413227, 13152.605421837361, 13258.337083145901, 13284.867151328459, 13305.86694133056, 13328.333583320893, 12191.207571507824, 12231.633051008484, 12340.938295308555, 12401.937990310082, 12435.253884766942, 4184.205001049791, 4212.641925436342, 4229.936550951707, 4401.977990110061, 4441.378207051015, 94576.0, 98692.013079869, 100062.49968750183, 103912.0, 104244.47877760639, 9138.268938484905, 10398.896011039793, 10475.1096156826, 10527.157827373792, 10923.399213043358, 19371.4188574343, 20175.293864714666, 20476.0, 20843.687344689537, 20873.26943556968, 7749.690012399554, 7837.412194085467, 7852.960735196401, 7920.564368959647, 7968.362530997506, 4310.870673879788, 4351.6083552479795, 4381.978090109529, 4444.400005999149, 4560.338750881104, 3604.7656902301264, 3666.7983260920905, 3670.3576874046935, 3710.165212827146, 3715.6098609645596, 649.5485637482, 651.9250286217051, 654.443722835586, 664.7573635622963, 672.1530871102447, 625.612120485293, 626.9059641053879, 638.5083485716066, 661.7915356662636, 672.5729161982176, 9133.634654613874, 9414.0, 9539.61841526345, 9572.56923438447, 10011.899881001242, 517.0408891506277, 554.7974989129019, 560.403170623285, 623.2925629410561, 702.8945658151318, 3925.4700615417123, 3935.4490371348033, 3984.7210695251633, 4498.280275156025, 4545.659075569345, 86548.0, 90900.54549727209, 91135.0, 92561.0743892566, 93775.062249378, 78909.0, 79520.0, 80537.59731201307, 82154.58922705348, 83615.58192209122, 74879.25120748831, 74898.62550687321, 76380.0, 76977.0, 77721.61139194267, 8804.911950880409, 8810.867836982323, 8874.979377371685, 8881.511516866634, 9078.773030674285, 39852.800735996134, 46903.53096468992, 48384.032319352715, 49415.752921235166, 50087.248691268935, 66927.0, 67764.6611766938, 69153.0, 69184.65407672929, 69430.65284673544, 10650.360978341014, 11415.200935934405, 11528.82706759416, 11540.076793856304, 11554.537818487166, 12475.5009799607, 12668.619941401772, 12669.493220271086, 12746.808797867854, 12893.677658058623, 11856.170068095496, 11892.286462812259, 11921.94039029834, 12046.972870487281, 12053.096017798525, 11976.640700778991, 11999.880001199876, 12141.69645758863, 12223.93888030554, 12541.623751287476, 11563.132765042486, 11816.468258928197, 12037.699057523632, 12090.879091209326, 12448.439820208294, 10154.593816247267, 10292.0, 10343.482825858828, 10376.325538839952, 10497.10774584169, 9646.42121472714, 10244.282900197213, 10305.0, 10305.53625086888, 10324.122449591869], "value": 7158.468967838527, "unit": "score"}], "name": "dromaeo_css", "value": 6994.760489012538, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 113.0, 113.0, 113.0, 114.0, 113.0, 114.0, 110.0, 113.0], "value": 112.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 121.0, 109.0, 148.0, 111.0, 111.0, 111.0, 110.0, 130.0, 116.0], "value": 121.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 183.0, 184.0, 186.0, 184.0, 186.0, 186.0, 179.0, 182.0, 185.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 59.0, 87.0, 62.0, 59.0, 58.0, 59.0, 75.0, 59.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 71.0, 86.0, 70.0, 69.0, 68.0, 84.0, 69.0, 69.0, 84.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 115.0, 171.0, 118.0, 112.0, 109.0, 112.0, 108.0, 110.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 97.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 82.0, 84.0, 84.0, 85.0, 85.0, 84.0, 85.0, 91.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 58.0, 56.0, 54.0, 55.0, 53.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 83.0, 73.0, 72.0, 71.0, 70.0, 73.0, 69.0, 68.0], "value": 71.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 109.0, 107.0, 88.0, 90.0, 86.0, 89.0, 90.0, 89.0], "value": 94.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 140.0, 140.0, 138.0, 140.0, 137.0, 152.0, 143.0, 212.0, 174.0], "value": 151.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 168.0, 179.0, 171.0, 169.0, 170.0, 186.0, 207.0, 172.0, 166.0], "value": 176.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 68.0, 66.0, 67.0, 67.0, 66.0, 66.0, 68.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1474.8, "alertThreshold": 2.0}]} 04:57:33 INFO - Return code: 0 04:57:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:33 INFO - # TBPL SUCCESS # 04:57:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:33 INFO - 2016-12-18 04:57:33.669 screenresolution[2377:299064] starting screenresolution argv=screenresolution get 04:57:33 INFO - 2016-12-18 04:57:33.672 screenresolution[2377:299064] Display 0: 1600x1200x32@60 04:57:33 INFO - 2016-12-18 04:57:33.678 screenresolution[2378:299067] starting screenresolution argv=screenresolution list 04:57:33 INFO - Available Modes on Display 0 04:57:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:33 INFO - Intel Iris: 04:57:33 INFO - Chipset Model: Intel Iris 04:57:33 INFO - Type: GPU 04:57:33 INFO - Bus: Built-In 04:57:33 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:33 INFO - Vendor: Intel (0x8086) 04:57:33 INFO - Device ID: 0x0a2e 04:57:33 INFO - Revision ID: 0x0009 04:57:33 INFO - Displays: 04:57:33 INFO - Display: 04:57:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:33 INFO - Display Serial Number: 1600x1200 60 04:57:33 INFO - Main Display: Yes 04:57:33 INFO - Mirror: Off 04:57:33 INFO - Online: Yes 04:57:33 INFO - Rotation: Supported 04:57:33 INFO - Return code: 0 04:57:33 INFO - Running post-action listener: _resource_record_post_action 04:57:33 INFO - [mozharness: 2016-12-18 12:57:33.914951Z] Finished run-tests step (success) 04:57:33 INFO - Running post-run listener: _resource_record_post_run 04:57:33 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 6914560; Write bytes: 551777280; Read time: 58; Write time: 1878 04:57:33 INFO - TinderboxPrint: CPU usage
53.5% 04:57:33 INFO - TinderboxPrint: I/O read bytes / time
6,914,560 / 58 04:57:33 INFO - TinderboxPrint: I/O write bytes / time
551,777,280 / 1,878 04:57:33 INFO - TinderboxPrint: CPU idle
2,238.8 (46.5%) 04:57:33 INFO - TinderboxPrint: CPU system
962.9 (20.0%) 04:57:33 INFO - TinderboxPrint: CPU user
1,616.0 (33.5%) 04:57:33 INFO - TinderboxPrint: Swap in / out
263,708,672 / 0 04:57:33 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 226439680; Write bytes: 221718528; Read time: 16307; Write time: 446 04:57:33 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 6914560; Write bytes: 299793408; Read time: 58; Write time: 1376 04:57:34 INFO - Running post-run listener: _upload_blobber_files 04:57:34 INFO - Blob upload gear active. 04:57:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:34 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 04:57:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:57:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:57:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:35 INFO - (blobuploader) - INFO - Done attempting. 04:57:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:36 INFO - (blobuploader) - INFO - Done attempting. 04:57:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:57:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:57:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:38 INFO - (blobuploader) - INFO - Done attempting. 04:57:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:40 INFO - (blobuploader) - INFO - Done attempting. 04:57:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:40 INFO - Return code: 0 04:57:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2908adadb2d8b26127a132e2ccec02f10ff5f57363db2d74ea56d0d099a1e558fa81dbcda7221eca375b8f2c832cbb8209f60e1cd1733d99f63d72fdae050a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/739c71a2ac41b5e612f130f1a77871aff1ab2ab2feba9bea8afbd05ff7008c5b8463a8bf67b3f8a0f020d2bcf9960349edf7b8de4c6050ac9316f11764f830ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45369ad58f71aa4e0665dc2038d188e6a648f9d005468c6e0a1da2e091b153d5dfc594ae5dc4bdd1c576c92e2b40069f4f8d9ecc2a14735279e0a96127a69e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38314296d7fe0998e3e15886fa5d8293834fb4a5b904f3eda47e02c119a5ec0b5a185484c5d76b83df2ffbb16ae5e710fe2f0cd7ecd4c80d5f52593ae791906"} 04:57:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:40 INFO - Contents: 04:57:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2908adadb2d8b26127a132e2ccec02f10ff5f57363db2d74ea56d0d099a1e558fa81dbcda7221eca375b8f2c832cbb8209f60e1cd1733d99f63d72fdae050a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/739c71a2ac41b5e612f130f1a77871aff1ab2ab2feba9bea8afbd05ff7008c5b8463a8bf67b3f8a0f020d2bcf9960349edf7b8de4c6050ac9316f11764f830ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45369ad58f71aa4e0665dc2038d188e6a648f9d005468c6e0a1da2e091b153d5dfc594ae5dc4bdd1c576c92e2b40069f4f8d9ecc2a14735279e0a96127a69e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38314296d7fe0998e3e15886fa5d8293834fb4a5b904f3eda47e02c119a5ec0b5a185484c5d76b83df2ffbb16ae5e710fe2f0cd7ecd4c80d5f52593ae791906"} 04:57:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:40 INFO - Copying logs to upload dir... 04:57:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.301872 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-12-18 04:57:40.655163) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-18 04:57:40.659312) ========= 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.b6R7drJDns/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.z79u8ei8ey/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2908adadb2d8b26127a132e2ccec02f10ff5f57363db2d74ea56d0d099a1e558fa81dbcda7221eca375b8f2c832cbb8209f60e1cd1733d99f63d72fdae050a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/739c71a2ac41b5e612f130f1a77871aff1ab2ab2feba9bea8afbd05ff7008c5b8463a8bf67b3f8a0f020d2bcf9960349edf7b8de4c6050ac9316f11764f830ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45369ad58f71aa4e0665dc2038d188e6a648f9d005468c6e0a1da2e091b153d5dfc594ae5dc4bdd1c576c92e2b40069f4f8d9ecc2a14735279e0a96127a69e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38314296d7fe0998e3e15886fa5d8293834fb4a5b904f3eda47e02c119a5ec0b5a185484c5d76b83df2ffbb16ae5e710fe2f0cd7ecd4c80d5f52593ae791906"} build_url:https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011211 build_url: 'https://queue.taskcluster.net/v1/task/Jd2yJHUcRkGiyftRodloVg/artifacts/public/build/firefox-53.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5f2908adadb2d8b26127a132e2ccec02f10ff5f57363db2d74ea56d0d099a1e558fa81dbcda7221eca375b8f2c832cbb8209f60e1cd1733d99f63d72fdae050a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/739c71a2ac41b5e612f130f1a77871aff1ab2ab2feba9bea8afbd05ff7008c5b8463a8bf67b3f8a0f020d2bcf9960349edf7b8de4c6050ac9316f11764f830ac", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e45369ad58f71aa4e0665dc2038d188e6a648f9d005468c6e0a1da2e091b153d5dfc594ae5dc4bdd1c576c92e2b40069f4f8d9ecc2a14735279e0a96127a69e5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f38314296d7fe0998e3e15886fa5d8293834fb4a5b904f3eda47e02c119a5ec0b5a185484c5d76b83df2ffbb16ae5e710fe2f0cd7ecd4c80d5f52593ae791906"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-18 04:57:40.694577) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 04:57:40.694931) ========= 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.b6R7drJDns/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.z79u8ei8ey/Listeners TMPDIR=/var/folders/lc/vwq10pn53dlcxm0t40pjj8vm00000w/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.005288 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-18 04:57:40.744635) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 04:57:40.744989) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-18 04:57:40.745313) ========= ========= Total master_lag: 0.20 =========