builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0246 starttime: 1488735932.03 results: success (0) buildid: 20170305082323 builduid: 2265a4102068412eb39886644b4f9f62 revision: 4b6a130cc3424f17b07220bd23c2c70c4f32e860 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:32.027484) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:32.028188) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:32.028686) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:32.057716) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:32.058352) ========= 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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-05 09:45:32-- 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% 153M=0s 2017-03-05 09:45:32 (153 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.166537 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:32.249980) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:32.250313) ========= 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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.030590 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:32.303749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-05 09:45:32.304129) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b6a130cc3424f17b07220bd23c2c70c4f32e860 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 4b6a130cc3424f17b07220bd23c2c70c4f32e860 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DqEIzJwKjF/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.sGbzSOf1a6/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-05 09:45:32,412 truncating revision to first 12 chars 2017-03-05 09:45:32,412 Setting DEBUG logging. 2017-03-05 09:45:32,412 attempt 1/10 2017-03-05 09:45:32,412 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/4b6a130cc342?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-05 09:45:33,109 unpacking tar archive at: mozilla-aurora-4b6a130cc342/testing/mozharness/ program finished with exit code 0 elapsedTime=0.981639 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-05 09:45:33.309766) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:33.310085) ========= script_repo_revision: 4b6a130cc3424f17b07220bd23c2c70c4f32e860 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:33.310472) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:33.310780) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 09:45:33.330869) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-05 09:45:33.331245) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DqEIzJwKjF/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.sGbzSOf1a6/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:45:33 INFO - MultiFileLogger online at 20170305 09:45:33 in /builds/slave/test 09:45:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:45:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:45:33 INFO - {'append_to_log': False, 09:45:33 INFO - 'base_work_dir': '/builds/slave/test', 09:45:33 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:45:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:45:33 INFO - 'branch': 'Mozilla-Aurora', 09:45:33 INFO - 'buildbot_json_path': 'buildprops.json', 09:45:33 INFO - 'config_files': ('talos/mac_config.py',), 09:45:33 INFO - 'default_actions': ('clobber', 09:45:33 INFO - 'read-buildbot-config', 09:45:33 INFO - 'download-and-extract', 09:45:33 INFO - 'populate-webroot', 09:45:33 INFO - 'create-virtualenv', 09:45:33 INFO - 'install', 09:45:33 INFO - 'run-tests'), 09:45:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:45:33 INFO - 'download_minidump_stackwalk': True, 09:45:33 INFO - 'download_symbols': 'ondemand', 09:45:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:45:33 INFO - 'tooltool.py': '/tools/tooltool.py', 09:45:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:45:33 INFO - '/tools/misc-python/virtualenv.py')}, 09:45:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:45:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:45:33 INFO - 'installer_path': 'installer.exe', 09:45:33 INFO - 'log_level': 'info', 09:45:33 INFO - 'log_name': 'talos', 09:45:33 INFO - 'log_to_console': True, 09:45:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:45:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:45:33 INFO - 'opt_config_files': (), 09:45:33 INFO - 'pip_index': False, 09:45:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:45:33 INFO - 'cmd': ('bash', 09:45:33 INFO - '-c', 09:45:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:45:33 INFO - 'enabled': True, 09:45:33 INFO - 'halt_on_failure': False, 09:45:33 INFO - 'name': 'check_screen_resolution'},), 09:45:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:45:33 INFO - 'cmd': ('bash', 09:45:33 INFO - '-c', 09:45:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:45:33 INFO - 'enabled': True, 09:45:33 INFO - 'halt_on_failure': False, 09:45:33 INFO - 'name': 'check_screen_resolution'},), 09:45:33 INFO - 'run_cmd_checks_enabled': True, 09:45:33 INFO - 'sps_profile': False, 09:45:33 INFO - 'sps_profile_interval': 0, 09:45:33 INFO - 'suite': 'dromaeojs', 09:45:33 INFO - 'system_bits': '32', 09:45:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:45:33 INFO - 'title': 't-yosemite-r7-0246', 09:45:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:45:33 INFO - 'use_talos_json': True, 09:45:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:45:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:45:33 INFO - 'work_dir': 'build'} 09:45:33 INFO - [mozharness: 2017-03-05 17:45:33.541189Z] Running clobber step. 09:45:33 INFO - Running pre-action listener: _resource_record_pre_action 09:45:33 INFO - Running main action method: clobber 09:45:33 INFO - rmtree: /builds/slave/test/build 09:45:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:45:35 INFO - Running post-action listener: _resource_record_post_action 09:45:35 INFO - [mozharness: 2017-03-05 17:45:35.962843Z] Finished clobber step (success) 09:45:35 INFO - [mozharness: 2017-03-05 17:45:35.962980Z] Running read-buildbot-config step. 09:45:35 INFO - Running pre-action listener: _resource_record_pre_action 09:45:35 INFO - Running main action method: read_buildbot_config 09:45:35 INFO - Using buildbot properties: 09:45:35 INFO - { 09:45:35 INFO - "project": "", 09:45:35 INFO - "product": "firefox", 09:45:35 INFO - "script_repo_revision": "production", 09:45:35 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 09:45:35 INFO - "repository": "", 09:45:35 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 09:45:35 INFO - "buildid": "20170305082323", 09:45:35 INFO - "pgo_build": "False", 09:45:35 INFO - "basedir": "/builds/slave/test", 09:45:35 INFO - "buildnumber": 79, 09:45:35 INFO - "slavename": "t-yosemite-r7-0246", 09:45:35 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:45:35 INFO - "platform": "yosemite_r7", 09:45:35 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:45:35 INFO - "branch": "mozilla-aurora", 09:45:35 INFO - "repo_path": "releases/mozilla-aurora", 09:45:35 INFO - "revision": "4b6a130cc3424f17b07220bd23c2c70c4f32e860", 09:45:35 INFO - "stage_platform": "macosx64", 09:45:35 INFO - "builduid": "2265a4102068412eb39886644b4f9f62", 09:45:35 INFO - "slavebuilddir": "test" 09:45:35 INFO - } 09:45:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 09:45:35 INFO - Running post-action listener: _resource_record_post_action 09:45:35 INFO - [mozharness: 2017-03-05 17:45:35.966275Z] Finished read-buildbot-config step (success) 09:45:35 INFO - [mozharness: 2017-03-05 17:45:35.966401Z] Running download-and-extract step. 09:45:35 INFO - Running pre-action listener: _resource_record_pre_action 09:45:35 INFO - Running main action method: download_and_extract 09:45:35 INFO - mkdir: /builds/slave/test/build/tests 09:45: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')]} 09:45:35 INFO - trying https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 09:45:35 INFO - Downloading https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 09:45:37 INFO - Downloaded 1199 bytes. 09:45:37 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 09:45:37 INFO - Using the following test package requirements: 09:45:37 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:45:37 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:45:37 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 09:45:37 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:45:37 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 09:45:37 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:45:37 INFO - u'jsshell-mac.zip'], 09:45:37 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:45:37 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 09:45:37 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 09:45:37 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:45:37 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 09:45:37 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:45:37 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 09:45:37 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:45:37 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 09:45:37 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 09:45:37 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 09:45:37 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:45:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:45:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:45:37 INFO - Fetch https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:45:38 INFO - Expected file size: 16357773 09:45:38 INFO - Obtained file size: 16357773 09:45:44 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:45:44 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 09:45:44 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:45:44 INFO - Fetch https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 09:45:45 INFO - Expected file size: 16357773 09:45:45 INFO - Obtained file size: 16357773 09:45:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 09:45:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:45:51 INFO - Fetch https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 09:45:53 INFO - Expected file size: 14403650 09:45:53 INFO - Obtained file size: 14403650 09:45: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')]} 09:45:53 INFO - trying https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:45:53 INFO - Downloading https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 09:45:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 09:45:56 INFO - Downloaded 73932546 bytes. 09:45:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:45:56 INFO - mkdir: /builds/slave/test/properties 09:45:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:45:56 INFO - Writing to file /builds/slave/test/properties/build_url 09:45:56 INFO - Contents: 09:45:56 INFO - build_url:https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 09:45:57 INFO - Running post-action listener: _resource_record_post_action 09:45:57 INFO - Running post-action listener: set_extra_try_arguments 09:45:57 INFO - [mozharness: 2017-03-05 17:45:57.670778Z] Finished download-and-extract step (success) 09:45:57 INFO - [mozharness: 2017-03-05 17:45:57.670915Z] Running populate-webroot step. 09:45:57 INFO - Running pre-action listener: _resource_record_pre_action 09:45:57 INFO - Running main action method: populate_webroot 09:45:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:45:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:45:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:45:57 INFO - '--tppagecycles', 09:45:57 INFO - '7'], 09:45:57 INFO - 'tests': ['tsvgm']}}, 09:45:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:45:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:45:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:45:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:45:57 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:45:57 INFO - 'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:57 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:45:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:45:57 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:45:57 INFO - 'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['damp', 'tps']}, 09:45:57 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:45:57 INFO - 'tests': ['damp', 'tps']}, 09:45:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['dromaeo_dom']}, 09:45:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:45:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['basic_compositor_video']}, 09:45:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:45:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other-e10s': {'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['a11yr', 09:45:57 INFO - 'ts_paint', 09:45:57 INFO - 'tpaint', 09:45:57 INFO - 'sessionrestore', 09:45:57 INFO - 'sessionrestore_no_auto_restore', 09:45:57 INFO - 'tabpaint']}, 09:45:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['tsvgx', 09:45:57 INFO - 'tsvgr_opacity', 09:45:57 INFO - 'tart', 09:45:57 INFO - 'tscrollx', 09:45:57 INFO - 'cart', 09:45:57 INFO - 'tsvg_static']}, 09:45:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:45:57 INFO - 'tsvgr_opacity', 09:45:57 INFO - 'tart', 09:45:57 INFO - 'tscrollx', 09:45:57 INFO - 'cart', 09:45:57 INFO - 'tsvg_static']}, 09:45:57 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:45:57 INFO - 'talos_options': ['--disable-e10s'], 09:45:57 INFO - 'tests': ['tp5o']}, 09:45:57 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:45:57 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:45:57 INFO - 'talos_options': ['--disable-e10s', 09:45:57 INFO - '--xperf_path', 09:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:57 INFO - 'tests': ['tp5n']}, 09:45:57 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:45:57 INFO - 'talos_options': ['--xperf_path', 09:45:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:45:57 INFO - 'tests': ['tp5n']}}, 09:45:57 INFO - 'talos.zip': {'path': '', 09:45:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:45:57 INFO - Running post-action listener: _resource_record_post_action 09:45:57 INFO - [mozharness: 2017-03-05 17:45:57.689283Z] Finished populate-webroot step (success) 09:45:57 INFO - [mozharness: 2017-03-05 17:45:57.689424Z] Running create-virtualenv step. 09:45:57 INFO - Running pre-action listener: _resource_record_pre_action 09:45:57 INFO - Running main action method: create_virtualenv 09:45:57 INFO - Creating virtualenv /builds/slave/test/build/venv 09:45:57 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 09:45:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:45:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:45:57 INFO - Using real prefix '/tools/python27' 09:45:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:45:58 INFO - Installing distribute.............................................................................................................................................................................................done. 09:46:01 INFO - Installing pip.................done. 09:46:01 INFO - Return code: 0 09:46:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:46:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:46:01 INFO - Reading from file tmpfile_stdout 09:46:01 INFO - Output received: 09:46:01 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) 09:46:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:46:01 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')]} 09:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:01 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')]} 09:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:01 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:01 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 09:46:01 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 09:46:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:01 INFO - 'HOME': '/Users/cltbld', 09:46:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:01 INFO - 'LOGNAME': 'cltbld', 09:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:01 INFO - 'MOZ_NO_REMOTE': '1', 09:46:01 INFO - 'NO_EM_RESTART': '1', 09:46:01 INFO - 'PAGER': '/bin/cat', 09:46:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:01 INFO - 'PWD': '/builds/slave/test', 09:46:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:01 INFO - 'SHELL': '/bin/bash', 09:46:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:01 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:01 INFO - 'USER': 'cltbld', 09:46:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:01 INFO - 'XPC_FLAGS': '0x0', 09:46:01 INFO - 'XPC_SERVICE_NAME': '0', 09:46:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:01 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 09:46:01 INFO - Cleaning up... 09:46:01 INFO - Return code: 0 09:46:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:46:01 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')]} 09:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:01 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')]} 09:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:01 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:01 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 09:46:01 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 09:46:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:01 INFO - 'HOME': '/Users/cltbld', 09:46:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:01 INFO - 'LOGNAME': 'cltbld', 09:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:01 INFO - 'MOZ_NO_REMOTE': '1', 09:46:01 INFO - 'NO_EM_RESTART': '1', 09:46:01 INFO - 'PAGER': '/bin/cat', 09:46:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:01 INFO - 'PWD': '/builds/slave/test', 09:46:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:01 INFO - 'SHELL': '/bin/bash', 09:46:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:01 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:01 INFO - 'USER': 'cltbld', 09:46:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:01 INFO - 'XPC_FLAGS': '0x0', 09:46:01 INFO - 'XPC_SERVICE_NAME': '0', 09:46:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:02 INFO - Downloading/unpacking psutil>=3.1.1 09:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:46:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:06 INFO - Installing collected packages: psutil 09:46:06 INFO - Running setup.py install for psutil 09:46:06 INFO - building 'psutil._psutil_osx' extension 09:46:06 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 09:46:06 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 09:46:06 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 09:46:06 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 09:46:06 INFO - building 'psutil._psutil_posix' extension 09:46:06 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 09:46:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:46:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:46:07 INFO - ^ 09:46:07 INFO - 1 warning generated. 09:46:07 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 09:46:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:46:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:46:07 INFO - Successfully installed psutil 09:46:07 INFO - Cleaning up... 09:46:07 INFO - Return code: 0 09:46:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:07 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:07 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 09:46:07 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 09:46:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:07 INFO - 'HOME': '/Users/cltbld', 09:46:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:07 INFO - 'LOGNAME': 'cltbld', 09:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:07 INFO - 'MOZ_NO_REMOTE': '1', 09:46:07 INFO - 'NO_EM_RESTART': '1', 09:46:07 INFO - 'PAGER': '/bin/cat', 09:46:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:07 INFO - 'PWD': '/builds/slave/test', 09:46:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:07 INFO - 'SHELL': '/bin/bash', 09:46:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:07 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:07 INFO - 'USER': 'cltbld', 09:46:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:07 INFO - 'XPC_FLAGS': '0x0', 09:46:07 INFO - 'XPC_SERVICE_NAME': '0', 09:46:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:07 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:46:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:46:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:46:10 INFO - Installing collected packages: mozsystemmonitor 09:46:10 INFO - Running setup.py install for mozsystemmonitor 09:46:10 INFO - Successfully installed mozsystemmonitor 09:46:10 INFO - Cleaning up... 09:46:10 INFO - Return code: 0 09:46:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:46:10 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')]} 09:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:10 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')]} 09:46:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:10 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:10 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 09:46:10 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 09:46:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:10 INFO - 'HOME': '/Users/cltbld', 09:46:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:10 INFO - 'LOGNAME': 'cltbld', 09:46:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:10 INFO - 'MOZ_NO_REMOTE': '1', 09:46:10 INFO - 'NO_EM_RESTART': '1', 09:46:10 INFO - 'PAGER': '/bin/cat', 09:46:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:10 INFO - 'PWD': '/builds/slave/test', 09:46:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:10 INFO - 'SHELL': '/bin/bash', 09:46:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:10 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:10 INFO - 'USER': 'cltbld', 09:46:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:10 INFO - 'XPC_FLAGS': '0x0', 09:46:10 INFO - 'XPC_SERVICE_NAME': '0', 09:46:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:10 INFO - Downloading/unpacking jsonschema==2.5.1 09:46:10 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 09:46:10 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 09:46:10 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 09:46:10 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 09:46:10 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 09:46:10 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 09:46:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:46:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46: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 09:46:13 INFO - Downloading functools32-3.2.3-2.tar.gz 09:46:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:46:13 INFO - warning: no files found matching '*.txt' 09:46:13 INFO - no previously-included directories found matching 'build' 09:46:13 INFO - no previously-included directories found matching 'dist' 09:46:13 INFO - no previously-included directories found matching '.git*' 09:46:13 INFO - Installing collected packages: jsonschema, functools32 09:46:14 INFO - Running setup.py install for functools32 09:46:14 INFO - warning: no files found matching '*.txt' 09:46:14 INFO - no previously-included directories found matching 'build' 09:46:14 INFO - no previously-included directories found matching 'dist' 09:46:14 INFO - no previously-included directories found matching '.git*' 09:46:14 INFO - Successfully installed jsonschema functools32 09:46:14 INFO - Cleaning up... 09:46:14 INFO - Return code: 0 09:46:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:46:14 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')]} 09:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:14 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')]} 09:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:14 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:14 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 09:46:14 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 09:46:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:14 INFO - 'HOME': '/Users/cltbld', 09:46:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:14 INFO - 'LOGNAME': 'cltbld', 09:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:14 INFO - 'MOZ_NO_REMOTE': '1', 09:46:14 INFO - 'NO_EM_RESTART': '1', 09:46:14 INFO - 'PAGER': '/bin/cat', 09:46:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:14 INFO - 'PWD': '/builds/slave/test', 09:46:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:14 INFO - 'SHELL': '/bin/bash', 09:46:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:14 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:14 INFO - 'USER': 'cltbld', 09:46:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:14 INFO - 'XPC_FLAGS': '0x0', 09:46:14 INFO - 'XPC_SERVICE_NAME': '0', 09:46:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:46:14 INFO - Cleaning up... 09:46:14 INFO - Return code: 0 09:46:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:46:14 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')]} 09:46:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:14 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')]} 09:46:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:14 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:14 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 09:46:14 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 09:46:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:14 INFO - 'HOME': '/Users/cltbld', 09:46:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:14 INFO - 'LOGNAME': 'cltbld', 09:46:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:14 INFO - 'MOZ_NO_REMOTE': '1', 09:46:14 INFO - 'NO_EM_RESTART': '1', 09:46:14 INFO - 'PAGER': '/bin/cat', 09:46:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:14 INFO - 'PWD': '/builds/slave/test', 09:46:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:14 INFO - 'SHELL': '/bin/bash', 09:46:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:14 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:14 INFO - 'USER': 'cltbld', 09:46:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:14 INFO - 'XPC_FLAGS': '0x0', 09:46:14 INFO - 'XPC_SERVICE_NAME': '0', 09:46:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:14 INFO - Downloading/unpacking blobuploader==1.2.4 09:46:14 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 09:46:14 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 09:46:14 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 09:46:14 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 09:46:14 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 09:46:14 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 09:46:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:46:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:46:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:46:17 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 09:46:17 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 09:46:17 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 09:46:17 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 09:46:17 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 09:46:17 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 09:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:46:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:46:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:46:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:46:18 INFO - Downloading docopt-0.6.1.tar.gz 09:46:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:46:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:46:18 INFO - Running setup.py install for blobuploader 09:46:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:46:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:46:18 INFO - Running setup.py install for requests 09:46:19 INFO - Running setup.py install for docopt 09:46:19 INFO - Successfully installed blobuploader requests docopt 09:46:19 INFO - Cleaning up... 09:46:19 INFO - Return code: 0 09:46:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:19 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:19 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 09:46:19 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 09:46:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:19 INFO - 'HOME': '/Users/cltbld', 09:46:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:19 INFO - 'LOGNAME': 'cltbld', 09:46:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:19 INFO - 'MOZ_NO_REMOTE': '1', 09:46:19 INFO - 'NO_EM_RESTART': '1', 09:46:19 INFO - 'PAGER': '/bin/cat', 09:46:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:19 INFO - 'PWD': '/builds/slave/test', 09:46:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:19 INFO - 'SHELL': '/bin/bash', 09:46:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:19 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:19 INFO - 'USER': 'cltbld', 09:46:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:19 INFO - 'XPC_FLAGS': '0x0', 09:46:19 INFO - 'XPC_SERVICE_NAME': '0', 09:46:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:19 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-fCQ_VI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-kUm0A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-6tJbrg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-JgxzBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-uLQZoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-CRpX4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-GUmmms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-wkvZvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-LomYKs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-fQT9cz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:20 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Rk_ni3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:21 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-yKfNsx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:21 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-1JLEdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:21 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-pIEfdk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:21 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Vk6akz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:21 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-RehjB1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:21 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-i_HzKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:46:21 INFO - Running setup.py install for manifestparser 09:46:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:46:21 INFO - Running setup.py install for mozcrash 09:46:21 INFO - Running setup.py install for mozdebug 09:46:22 INFO - Running setup.py install for mozdevice 09:46:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:46:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:46:22 INFO - Running setup.py install for mozfile 09:46:22 INFO - Running setup.py install for mozhttpd 09:46:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:46:22 INFO - Running setup.py install for mozinfo 09:46:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:46:22 INFO - Running setup.py install for mozInstall 09:46:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:46:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:46:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:46:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:46:22 INFO - Running setup.py install for mozleak 09:46:22 INFO - Running setup.py install for mozlog 09:46:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:46:23 INFO - Running setup.py install for moznetwork 09:46:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:46:23 INFO - Running setup.py install for mozprocess 09:46:23 INFO - Running setup.py install for mozprofile 09:46:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:46:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:46:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:46:23 INFO - Running setup.py install for mozrunner 09:46:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:46:23 INFO - Running setup.py install for mozscreenshot 09:46:23 INFO - Running setup.py install for moztest 09:46:24 INFO - Running setup.py install for mozversion 09:46:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:46:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:46:24 INFO - Cleaning up... 09:46:24 INFO - Return code: 0 09:46:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:24 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:24 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 09:46:24 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 09:46:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:24 INFO - 'HOME': '/Users/cltbld', 09:46:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:24 INFO - 'LOGNAME': 'cltbld', 09:46:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:24 INFO - 'MOZ_NO_REMOTE': '1', 09:46:24 INFO - 'NO_EM_RESTART': '1', 09:46:24 INFO - 'PAGER': '/bin/cat', 09:46:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:24 INFO - 'PWD': '/builds/slave/test', 09:46:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:24 INFO - 'SHELL': '/bin/bash', 09:46:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:24 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:24 INFO - 'USER': 'cltbld', 09:46:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:24 INFO - 'XPC_FLAGS': '0x0', 09:46:24 INFO - 'XPC_SERVICE_NAME': '0', 09:46:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:46:24 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-2xqLFe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:46:24 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)) 09:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:46:24 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-aZ50JS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:46:24 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)) 09:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:46:24 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Qet0XX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:46:24 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)) 09:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:46:24 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-CvkUiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:46:24 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)) 09:46:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:46:24 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-E0diT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:46:25 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)) 09:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:46:25 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-p39Gzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:46:25 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)) 09:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:46:25 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-dgeJbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:46:25 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)) 09:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:46:25 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-3oYYRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:46:25 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)) 09:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:46:25 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-4Oqghp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:46:25 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)) 09:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:46:25 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-7riDWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:46:25 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)) 09:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:46:25 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-1niXam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:46:25 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)) 09:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:46:25 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-zdDTnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:46:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:46:25 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-goi_tt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:46:25 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)) 09:46:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:46:25 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-YKfavc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:46:26 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)) 09:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:26 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-IJCIqR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:46:26 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)) 09:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:46:26 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Q425ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:46:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:46:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:46:26 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-AuvQko-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:46:26 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)) 09:46:26 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)) 09:46:26 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)) 09:46:26 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)) 09:46:26 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)) 09:46:26 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)) 09:46:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:46:26 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 09:46:26 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 09:46:26 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 09:46:26 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 09:46:26 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 09:46:26 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 09:46:28 INFO - Downloading blessings-1.6.tar.gz 09:46:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:46:29 INFO - Installing collected packages: blessings 09:46:29 INFO - Running setup.py install for blessings 09:46:29 INFO - Successfully installed blessings 09:46:29 INFO - Cleaning up... 09:46:29 INFO - Return code: 0 09:46:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:46:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:29 INFO - Reading from file tmpfile_stdout 09:46:29 INFO - Current package versions: 09:46:29 INFO - blessings == 1.6 09:46:29 INFO - blobuploader == 1.2.4 09:46:29 INFO - docopt == 0.6.1 09:46:29 INFO - functools32 == 3.2.3-2 09:46:29 INFO - jsonschema == 2.5.1 09:46:29 INFO - manifestparser == 1.1 09:46:29 INFO - mozInstall == 1.12 09:46:29 INFO - mozcrash == 1.0 09:46:29 INFO - mozdebug == 0.1 09:46:29 INFO - mozdevice == 0.49 09:46:29 INFO - mozfile == 1.2 09:46:29 INFO - mozhttpd == 0.7 09:46:29 INFO - mozinfo == 0.9 09:46:29 INFO - mozleak == 0.1 09:46:29 INFO - mozlog == 3.4 09:46:29 INFO - moznetwork == 0.27 09:46:29 INFO - mozprocess == 0.24 09:46:29 INFO - mozprofile == 0.28 09:46:29 INFO - mozrunner == 6.13 09:46:29 INFO - mozscreenshot == 0.1 09:46:29 INFO - mozsystemmonitor == 0.3 09:46:29 INFO - moztest == 0.8 09:46:29 INFO - mozversion == 1.4 09:46:29 INFO - psutil == 3.1.1 09:46:29 INFO - requests == 1.2.3 09:46:29 INFO - wsgiref == 0.1.2 09:46:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:46:29 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')]} 09:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:29 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')]} 09:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:29 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:29 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 09:46:29 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 09:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:29 INFO - 'HOME': '/Users/cltbld', 09:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:29 INFO - 'LOGNAME': 'cltbld', 09:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:29 INFO - 'MOZ_NO_REMOTE': '1', 09:46:29 INFO - 'NO_EM_RESTART': '1', 09:46:29 INFO - 'PAGER': '/bin/cat', 09:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:29 INFO - 'PWD': '/builds/slave/test', 09:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:29 INFO - 'SHELL': '/bin/bash', 09:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:29 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:29 INFO - 'USER': 'cltbld', 09:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:29 INFO - 'XPC_FLAGS': '0x0', 09:46:29 INFO - 'XPC_SERVICE_NAME': '0', 09:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:29 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)) 09:46:29 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)) 09:46:29 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)) 09:46:29 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)) 09:46:29 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)) 09:46:29 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)) 09:46:29 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)) 09:46:29 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)) 09:46:29 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)) 09:46:29 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)) 09:46:29 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)) 09:46:29 INFO - Cleaning up... 09:46:29 INFO - Return code: 0 09:46:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:46:29 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')]} 09:46:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:46:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:29 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')]} 09:46:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:46:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:46:29 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 0x107bfeb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107c01768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff59b4808b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, '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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 09:46:29 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 09:46:29 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 09:46:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:29 INFO - 'HOME': '/Users/cltbld', 09:46:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:29 INFO - 'LOGNAME': 'cltbld', 09:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:29 INFO - 'MOZ_NO_REMOTE': '1', 09:46:29 INFO - 'NO_EM_RESTART': '1', 09:46:29 INFO - 'PAGER': '/bin/cat', 09:46:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:29 INFO - 'PWD': '/builds/slave/test', 09:46:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:29 INFO - 'SHELL': '/bin/bash', 09:46:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:29 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:29 INFO - 'USER': 'cltbld', 09:46:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:29 INFO - 'XPC_FLAGS': '0x0', 09:46:29 INFO - 'XPC_SERVICE_NAME': '0', 09:46:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:46:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:46:30 INFO - Cleaning up... 09:46:30 INFO - Return code: 0 09:46:30 INFO - Running post-action listener: _resource_record_post_action 09:46:30 INFO - Running post-action listener: _start_resource_monitoring 09:46:30 INFO - Starting resource monitoring. 09:46:30 INFO - [mozharness: 2017-03-05 17:46:30.106007Z] Finished create-virtualenv step (success) 09:46:30 INFO - [mozharness: 2017-03-05 17:46:30.106972Z] Running install step. 09:46:30 INFO - Running pre-action listener: _resource_record_pre_action 09:46:30 INFO - Running main action method: install 09:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:46:30 INFO - Reading from file tmpfile_stdout 09:46:30 INFO - Detecting whether we're running mozinstall >=1.0... 09:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:46:30 INFO - Reading from file tmpfile_stdout 09:46:30 INFO - Output received: 09:46:30 INFO - Usage: mozinstall [options] installer 09:46:30 INFO - Options: 09:46:30 INFO - -h, --help show this help message and exit 09:46:30 INFO - -d DEST, --destination=DEST 09:46:30 INFO - Directory to install application into. [default: 09:46:30 INFO - "/builds/slave/test"] 09:46:30 INFO - --app=APP Application being installed. [default: firefox] 09:46:30 INFO - mkdir: /builds/slave/test/build/application 09:46:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:46:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:46:50 INFO - Reading from file tmpfile_stdout 09:46:50 INFO - Output received: 09:46:50 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:46:50 INFO - Running post-action listener: _resource_record_post_action 09:46:50 INFO - [mozharness: 2017-03-05 17:46:50.347384Z] Finished install step (success) 09:46:50 INFO - [mozharness: 2017-03-05 17:46:50.347527Z] Running run-tests step. 09:46:50 INFO - Running pre-action listener: _resource_record_pre_action 09:46:50 INFO - Running main action method: run_tests 09:46:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:46:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:46:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:46:50 INFO - 2017-03-05 09:46:50.362 screenresolution[1629:8201] starting screenresolution argv=screenresolution get 09:46:50 INFO - 2017-03-05 09:46:50.364 screenresolution[1629:8201] Display 0: 1600x1200x32@60 09:46:50 INFO - 2017-03-05 09:46:50.370 screenresolution[1630:8204] starting screenresolution argv=screenresolution list 09:46:50 INFO - Available Modes on Display 0 09:46:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:46:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:46:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:46:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:46:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:46:50 INFO - Intel Iris: 09:46:50 INFO - Chipset Model: Intel Iris 09:46:50 INFO - Type: GPU 09:46:50 INFO - Bus: Built-In 09:46:50 INFO - VRAM (Dynamic, Max): 1536 MB 09:46:50 INFO - Vendor: Intel (0x8086) 09:46:50 INFO - Device ID: 0x0a2e 09:46:50 INFO - Revision ID: 0x0009 09:46:50 INFO - Displays: 09:46:50 INFO - Display: 09:46:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:46:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:46:50 INFO - Display Serial Number: 1600x1200 60 09:46:50 INFO - Main Display: Yes 09:46:50 INFO - Mirror: Off 09:46:50 INFO - Online: Yes 09:46:50 INFO - Rotation: Supported 09:46:50 INFO - Return code: 0 09:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:46:50 INFO - Python 2.7.3 09:46:50 INFO - Return code: 0 09:46:50 INFO - grabbing minidump binary from tooltool 09:46:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:46:50 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 0x1079dcd30>, '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 0x107903db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1079d1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:46:50 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 09:46:50 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 09:46:50 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 09:46:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:46:50 INFO - Return code: 0 09:46:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:46:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:46:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:46:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:46:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:46:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--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 09:46:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0246 --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 09:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DqEIzJwKjF/Render', 09:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:46:50 INFO - 'HOME': '/Users/cltbld', 09:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:46:50 INFO - 'LOGNAME': 'cltbld', 09:46:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:46:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:46:50 INFO - 'MOZ_NO_REMOTE': '1', 09:46:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:46:50 INFO - 'NO_EM_RESTART': '1', 09:46:50 INFO - 'PAGER': '/bin/cat', 09:46:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:46:50 INFO - 'PWD': '/builds/slave/test', 09:46:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:46:50 INFO - 'SHELL': '/bin/bash', 09:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.sGbzSOf1a6/Listeners', 09:46:50 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 09:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:46:50 INFO - 'USER': 'cltbld', 09:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:46:50 INFO - 'XPC_FLAGS': '0x0', 09:46:50 INFO - 'XPC_SERVICE_NAME': '0', 09:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:46:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--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 09:46:50 INFO - mozversion application_buildid: 20170305082323 09:46:50 INFO - mozversion application_changeset: 4b6a130cc3424f17b07220bd23c2c70c4f32e860 09:46:50 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:46:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:46:50 INFO - mozversion application_name: Firefox 09:46:50 INFO - mozversion application_remotingname: firefox-dev 09:46:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:46:50 INFO - mozversion application_vendor: Mozilla 09:46:50 INFO - mozversion application_version: 53.0a2 09:46:50 INFO - mozversion platform_buildid: 20170305082323 09:46:50 INFO - mozversion platform_changeset: 4b6a130cc3424f17b07220bd23c2c70c4f32e860 09:46:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:46:50 INFO - mozversion platform_version: 53.0a2 09:46:50 INFO - using testdate: 1488736010 09:46:50 INFO - actual date: 1488736010 09:46:50 INFO - starting webserver on 'localhost:49243' 09:46:50 INFO - SUITE-START | Running 2 tests 09:46:50 INFO - TEST-START | dromaeo_css 09:46:50 INFO - operating with platform_type : mac_ 09:46:50 INFO - Initialising browser for dromaeo_css test... 09:46:50 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmp7ADlp1/profile http://localhost:49243/getInfo.html) 09:46:53 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 09:46:53 INFO - PROCESS | 1640 | colorDepth:24 09:46:53 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 09:46:53 INFO - PROCESS | 1640 | __metrics 09:46:53 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:46:53 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:46:54 INFO - TEST-INFO | 1640: exit 0 09:46:54 INFO - Browser initialized. 09:46:54 INFO - Running cycle 1/1 for dromaeo_css test... 09:46:54 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmp7ADlp1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:47:06 INFO - PROCESS | 1643 | RSS: Main: 213151744 09:47:06 INFO - PROCESS | 1643 | 09:50:09 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 09:50:11 INFO - PROCESS | 1643 | RSS: Main: 381927424 09:50:11 INFO - PROCESS | 1643 | 09:51:55 INFO - PROCESS | 1643 | ************************* 09:51:55 INFO - PROCESS | 1643 | A coding exception was thrown and uncaught in a Task. 09:51:55 INFO - PROCESS | 1643 | 09:51:55 ERROR - PROCESS | 1643 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:51:55 INFO - PROCESS | 1643 | Full stack: 09:51:55 INFO - PROCESS | 1643 | ************************* 09:53:14 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 09:53:15 INFO - PROCESS | 1643 | RSS: Main: 358252544 09:53:15 INFO - PROCESS | 1643 | 09:56:17 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 09:56:18 INFO - PROCESS | 1643 | RSS: Main: 318128128 09:56:18 INFO - PROCESS | 1643 | 09:59:20 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 09:59:21 INFO - PROCESS | 1643 | RSS: Main: 326590464 09:59:21 INFO - PROCESS | 1643 | 10:02:25 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 10:02:25 INFO - PROCESS | 1643 | RSS: Main: 311349248 10:02:25 INFO - PROCESS | 1643 | 10:05:29 INFO - PROCESS | 1643 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 10:05:29 INFO - PROCESS | 1643 | RSS: Main: 383455232 10:05:29 INFO - PROCESS | 1643 | 10:05:29 INFO - PROCESS | 1643 | __start_tp_report 10:05:29 INFO - PROCESS | 1643 | _x_x_mozilla_page_load 10:05:29 INFO - PROCESS | 1643 | _x_x_mozilla_page_load_details 10:05:29 INFO - PROCESS | 1643 | |i|pagename|runs| 10:05:29 INFO - PROCESS | 1643 | |0;dojo.html;3283.294091770269;3308.0241328808;3336.2826992196674;3352.296017836254;3386.2888793353395;5554.722263886804;5641;5651.406602306755;5654.717264136792;5677.8580535486635;5586.022446071942;5728.455796699307;5741.483266506014;5743.684097374643;5791.82624521264;5184.792608295664;5223.895522089556;5256.001359741656;5260.368755749297;5310.070737620901;5191.636585439021;5195.350581177353;5309.601779866506;5323.441038690939;5360.597955153359;5236.266922630815;5246.685198888079;5267.47325267474;5280.023195708787;5303.363596368422;5271.2356708277275;5318.521333080042;5327.706976116312;5330.147176451749;5339.145736682131;5215.608829337815;5252.159654455307;5278.2082687596785;5285.048691235576;5304.496072873071;4677.4854765975715;5590.748416321276;5635.8591035224445;5665.603407761459;5679.432056794329;6223.937760622381;6244.469220116295;6254.499640028786;6276.96861515694;6278.277998030239;6248.812535623939;6296.244450665904;6304.968475157641;6323.715432805535;6329.715162817684;5604.971975140098;5714.828555143353;5716.485516303553;5832.679202643811;5845.707714614295;5252.369715634072;6241.344658810759;6287.96856015717;6340.714667839959;6359.20509936258;6139.3553676863285;6198.597091189058;6217.253929528486;6234.064890266496;6238.781642642576;6166.445019948136;6271.592346497463;6299.244090709144;6301.842453938688;6306.873862522724;5269.8933224023385;6131.162586540582;6176.413240742122;6197.628142311476;6273.0904018917;6280.026595877646;6291.339409362043;6291.842703932438;6297.905531416941;6308.148399965946;4988.501149884983;5035.571976382049;5035.949640503622;5036.320096786887;5074.797008119634;3712.925741485155;4395.033092719596;4410.29435290352;4431.180231657154;4439.755813430293;5847.473727364558;5878.853028674317;5881.206037184926;5904.143899134688;5921.348651648315;5123.487651234846;6146.108814222002;6202.875942481125;6291.402316779899;6295.842603934847;5723.227364305849;5782.653040817564;5794.884102318014;5803.187553742479;5813.069908814569;5440.564754819605;5446.101393270066;5449.237106805051;5449.373322067933;5458.836234912959;6284.465820405226;6303.243610766737;6336.334684858116;6383.0744542042075;6392.87214255703;6164.815055548341;6244.219472565929;6254.24949006104;6254.249490061222;6276.340984196594;6234.127222188807;6259.217597800275;6291.245050593958;6292.370762923671;6409.7115629795835;6248.062790581449;6266.843328916813;6289.371062893674;6301.243850737941;6303.054541818764;6280.591761535486;6284.874302513833;6290.779822706183;6295.307516173309;6308.810735677937;5998.1002849572915;6000.249968753906;6053.334133245251;6086.300075491198;6110.175126357884;6022.608530445507;6151.630902145886;6159.1069294951085;6171.413715697002;6185.195924529782;5969.940300597113;6000.789972350947;6011.398860113954;6021.096835474714;6023.789167379121;6026.849328766816;6067;6092.208012958287;6104.633721976696;6123.938760612336;5993.790217342372;6003.609765365237;6008.218931538872;6009.519238461;6016.09758536223 10:05:29 INFO - PROCESS | 1643 | |1;ext.html;429.71209289775845;446.21020793196044;502.8039064764742;513.207095038166;513.2839688634355;26118.869405652968;34597.654023459756;40353.99115022122;42411.363829542584;44452.110957780824;43590.78204608973;43893.561064389425;43897.78051109748;43919.56080439195;44152.77923610385;8394.496330220176;9164.541772911345;9356.719298421025;9367.906320936805;9377.484238366887;8443.451175673592;11157.995780379764;11389.658310250707;11398.316101033965;11596.53613855449;11375.772484550303;11480.71298217543;11498.19512634116;11512.539498420096;11529.654110376701;8425.199606037417;11382.317060976367;11432.714182145513;11448.656540303804;11471.827922581126;8410.831783364298;11033.889661103447;11313.434328283634;11324.547018119265;11517.078633709367;41480;41759.582404175875;41765.1646967059;41791.58208417907;41812.163756724694;3989.5611482736876;3997.8600748973645;4000.899977500586;4013.779242141681;4027.8791636250958;29416.852915735497;29419.97030103936;29489.11532654024;30647.927322543826;31017;3059.6481404638307;3176.872925082994;3196.360727854415;3238.724708399789;3340.148262193125;363773;363788;363864;364643;365603;63969;64102.6794866032;64220.67889660615;64255.67872160703;64293;68710.31289687139;68841;68863.3113668857;68895.3110468899;68966;16686.91535050218;16961.0671413071;16974;16976.236069376908;16977.575560610836;11774;12018.399080045963;12725.490980360866;12797.29614871191;12834.229946203071;17886.683870378547;22323.888380558317;22414.215502457337;22921.88539057294;22930.541389172122;8111.837763244702;8415.747527574182;8766.21104100634;8959.641614335354;8968.05835387288;872.8734333521604;900.6352427266968;904.8054668246227;926.5691453474167;942.3356533643764;30061.849690751405;30425.239369015508;30616.69383306183;31305.06084817459;31387;1046.1578429364283;1066.5040756048475;1082.242430298794;1100.070440477795;1107.5293000474767;15286.38854445832;15822.92088539573;15927.920360398124;15944.36222551085;16057.956232845061;677212;681818;682678;682959;684532;47880.5211947883;48229.75885120552;48346;48383.758081209366;48461.75769121132;1438.7293017614586;1440.7046555456106;1465.7508223602013;1480.7556753135611;1481.7703255995339;28827;29935;30050.54924176183;30393.84630753407;30657.846710767197;44336;53484;53791.731041344545;53798.19302710384;53879.19181212363;570904;572333;573645;573791;574491;43298.36131095174;43508;44032.77983610061;44179.33730994102;44277;47865;47873.521264786905;48453.75773121112;48935.04259829709;49639.25541116814;33182.66817331796;33262;39490.605093948696;39526;39818.80090599528;37130.257394852495;39104.41343379908;39761;40469.39295910505;40783;37358.439623405124;37415;37621.81189094037;37660.43509347417;37757.622423775414;33213.33573328568;33873.830630846685;34703.4794478078;34740.957771266905;34891.9532414028;24256.757432426155;24342.878285608458;24838;25121.748782512674;25499.6175057378 10:05:29 INFO - PROCESS | 1643 | |2;jquery.html;351.16247749118355;367.3901323802488;385.7723942873704;388.76091203909596;404.49236208558256;15442.459513917016;16275.430359937405;18036.909815450905;20848.58302833946;21356.57286854262;17466.825331746677;20478.692819607717;21130.683039754378;21744.673829892563;21786.89106554465;5154.433012368646;5312.150055991042;5312.867178320535;5316.175992721134;5604.439556044404;4812.205986012304;5905.084711869667;5914.290285165786;5923.940760592403;5932.822015339547;3888.5223615026252;4073.287174744408;5675.801346952858;5900.144479050535;5928.703564821742;5790;5941.187937679007;6013.939860601382;6043.879122417549;6052.848678783043;5830.038043722823;5830.067189249699;5836.649801011953;5837.241158649348;5838.532917366643;13286.468541258339;15562.766558501631;26341.604875926878;26454.941802327885;26654.46691066187;2577.2912449076466;2610.5040042391884;2637.103384849141;2659.8404095754317;2689.5696688529742;9987.90012099877;10049.34679245854;10059.849102263472;10559.208059395576;10570.365778053341;1736.2013473802067;1781.6792977264088;1784.7590575272432;1791.4177892185091;1807.2409587973084;100671;105054.94945050604;120033.39983300028;133504.6649533502;135684.5726170952;11737.295762254293;11811.468483918245;11926.701832454084;12069.189621556836;12428.62714118578;13000.934995324962;15940.362385504683;15963.361465541248;15990.36038558468;15998;8641.783955401166;8862.069482704352;8874.201321881063;9017.864732029026;9025.187733104052;8778.209961103532;8786.42888212277;8815.559222038872;8929.151730585583;8954.2836573074;4668.5798278155125;4674.555917187861;4765.11845308619;4778.761061946958;4840.951590484121;1967.852411069147;2001.128944436956;2010.8089731475486;2010.839132869367;2032.664610339307;858.390542714667;881.8456770065213;889.226373055446;893.2095095840228;917.1104029091771;21252.468688282916;22143.77856221417;22145.66781498279;22166.556668866855;22214.11143554272;886.499127992682;902.9413088149249;905.4114825363434;916.3310783128354;919.2278486071732;8890.421777684529;11401.657950261506;12333.814992775115;12365.938170309091;12753.979681625447;474193;568970;574015;600600;601247;107938;127240.36379818227;131357.68642313455;132661;136803;982.3614650477247;1032.8347464405658;1051.6844946516014;1055.1506037639774;1055.889131641182;19386.51533711612;19971.301004464774;20003.799962000194;20102.195912163348;20154.899225503777;50378.496215038846;52669;56133.71933140308;56656;56944.14583781164;85536.71694924457;86971.56514217389;88488;89553.55223223842;91089.63365549655;6859.965700171467;7712.72739997894;7938.404619653665;8328.791780205544;8564.828703425772;9233.307501937516;12466.252024878173;13111.409986550438;13425.462981480632;13722.588322349946;9107.453552786854;10002.899971000197;11388.032017278292;11391.601293954673;11650.6504804856;10934.179936504635;11062.668119956414;11305.7738845221;11462.312261264351;11526.769464610828;10483.213758967955;11398.658040258806;11420.600278990196;11795.941020294844;11853.940730296294;6602.273749887412;7366.373858221897;7510.173880872991;7676.884846727192;8434.451760635538;10514.211434142622;11084.168687348643;11230.045446136843;11435.085193184359;11746.706332341419 10:05:29 INFO - PROCESS | 1643 | |3;mootools.html;1311.7769979103552;1446.9710605787884;1457.387897083225;1465.223431581262;1468.1338010573759;8026.9197308026905;8440.704575339865;8443.83112337753;8443.831123377537;8444.28223600993;6480.546361754679;7419.814504637387;7623.123340815808;7640.274173953466;8252.91747082529;1924.191839427444;2280.076568989562;2333.2183718454253;2335.988320058406;2341.508283260517;2015.629372027021;2228.0308065991344;2296;2332.8133749300014;2351.3886389538757;1906.332783525762;2045.9897700511476;2083.2292051940726;2121.2999710095633;2231.5313784105356;2299.9425014374606;2316.745158032615;2320.153144102399;2320.33870346952;2321.58211521926;2257.645412752352;2304.884755762222;2321.5124823787023;2340.8595484271;2342.5314937012495;8265.669373225064;8347.998240211153;8349.206825351643;8350.164983501601;8358.791030224233;4078.796060197008;5036.420811606676;5203.19350500673;5204.479552044765;5216.37403511581;3278.4263553494216;3434.7767395119236;3448.6723761242642;3495.458203978362;3510.4558793387064;1127.7011591928062;1199.2804317409573;1201.1111777284746;1223.5350566784655;1233.0813543909844;10719;10744.677659670222;10770.676879693621;10774.407407592658;10816.405097719622;4506.842260520866;4726;4733.692309999839;4740.95259047412;4792.329073929653;7292.8176795579475;8603.053664096944;8635.266002389742;8643.481391116553;8651.264642505457;5136.614753893473;5137.691738495628;5138.820141295037;5141.305923700253;5146.871328216825;4618.399608050931;4734.573888349996;4822.300766388854;4825;4883.755812209375;2992.940141197164;3733.178700685845;3750.1187221003042;3788.431735239736;3793.5827059023486;1157.6932112990064;1157.8089615213396;1165.7435364219857;1170.455738081796;1173.9471723772451;831.4803247970019;855.1961156512858;868.1188593577398;894.6019021535354;925.0703043441433;4744.383230180055;5678.14827775837;5812.738426770806;5821.126830975388;5971.880562388728;952.618952419024;958.3100167879115;959.9616015359447;988.4761076629397;1030.8659874216303;2998.8200707957594;3446.2590543033366;3461.6365281645567;3590.4075827488696;3602.8759186685497;9659;9948.950255248677;9984.900150998543;9991.350562213433;9993.050660187417;8358.331333493306;9698.981606931311;9943.25425593069;9976.950115249523;9978.501074946224;7645.503042302233;7755.108162561265;7762.379009679212;7793.18171591986;7799.688012479551;5511.476409741068;5658.886822263614;5721.05602575587;5910.749676755863;5996.940030599638;9056.728298151065;9298.302627302844;9303.581338839904;9307.255419566283;9369.297302702189;6604.471642268511;8540.487570745776;8851.645934162561;9306.441613503212;9325.720228393158;6736.427403670743;6867.278935711678;7013.649317534205;7100.502964792415;7190.89213661785;7576.772696819105;7910.090339611018;7915.643796029308;7939.444238903452;8011.959940200495;6963.582185068912;7078.256783037707;7170.318819712119;7218;7326.597037162794;6267.4045965633195;7087.220405755466;7104.715811367488;7132.536385134949;7142.678579464041;6320.4311611955145;6385.201849768779;6400.775972840928;6477.611343319416;6478.093066970534;4750.477447480705;4756.310335001336;4810.5670489656095;4843.457850976738;4913.508649135058;4507.346434766875;4585.991081961963;4794.089123066607;4881.170201065898;4922.507749225192 10:05:29 INFO - PROCESS | 1643 | |4;prototype.html;349.501959707417;352.8006676227931;360.9639036096391;371.45952638910387;372.2926439764449;5195.168772996321;5313.910648317091;5314.9468505315035;5365.919511207335;5373.785048598052;4437.866863994085;5017.824376146836;5058.494150584939;5160.561352285051;5321.840344789653;3721.423179407196;3815.389537673973;3944.3097457944887;3965.2441553120593;4142.0473291143135;3575.910602234952;4024.6611586750837;4086.570910054446;4119.176164767058;4188.183304255671;3258.804471731704;3862.2854771867296;4011.9598804012026;4077.2660921034203;4147.688923330762;3412.5734283214597;3807.200487897545;3979.263836190314;4025.557188709254;4039.838406463738;3002.8439050965535;3007.9248018799485;3457.429524128516;3465.7227421806447;3467.711310535035;3919.8040097994985;4728.692634978715;4931.5315045070665;4945.901081978376;5198.9448230379985;3579.8926032219074;4119;4207.684423668237;4504.09918016398;4554.950272377443;4596.172688915994;4615.861524154281;5174.560162386202;5565.9443405565835;5660.29246344207;3151.8266495342746;3189.7448204143843;3747.8943711605143;3757.7745335279697;3802.7718336899875;5142.408623008327;5537.750801213915;5913.758110796694;5968.522518198533;6018.479189674046;3818.1790914952862;3849.615038496128;3849.711271654637;3850.0374906273432;3864.516935383077;3625.6736893679695;3776.6789822864816;3876.244132394156;3911.002694312932;3923.156521347924;4128.587141285848;4293.325603014827;4519.254323036728;4571.954280457153;4583.449986001701;5524.038966167033;5655.557832752704;5695.45893140151;5707;5761.53907687384;1164.5400066973668;1191.4876603060768;1202.4588934979295;1231.946685583831;1240.34881687115;793.595266414133;820.2248874813245;824.7773101262745;827.8096037911314;829.8796674482167;4779.784909679072;4948.857475503081;4951.504849515091;5156;5340.492653198017;4647.697899636512;5035.697858128524;5825.912611310834;5841.328247251536;5877.882442351129;4458.7547684877645;5220.825314304251;5277.23480095384;5337.306150200449;5347.82347883465;2518.6222066690143;2906.6193558059754;2934.457125431802;2937.911862644124;2942.29384947611;5405.378678124849;5756.539476841843;5764;5800.941990580124;5801.969310741291;4687.5781179693995;5196.402413722471;5475.123980163155;5645.633033852787;5711.457411545896;4927.43334516528;5358.383785864676;5733.885322293614;5769.278840144982;5778.653280803165;4561.589456948891;4657;5501.642393244426;5569.438058493139;5781.82654520365;4877.512248775094;5673.687947162945;5709.54323654115;5748.809410776892;5771.538276937918;5602.01712559609;5931.881362372815;6053.243344581927;6062.605930614496;6068.936561569088;3649.9817500912327;3905.7070719695566;4162.4796900387455;4236.978815105905;4243.130158317475;5814.651120932757;5825.592208545361;5854.151148083419;5854.151148083589;5862.7654893805475;4792.993471371051;5535.944640553543;5626.774929002794;5695.971520142372;5720.685362305113;5062.848114556569;5203.245529398292;5625.549956003428;5625.634333768292;5638.351589567253;4755.976220118877;4847.321375007572;5504.7155430495895;5528.783667593123;5534.1975413564005;4424.619626569737;5491.697956612425;5498.890022199454;5524.944750552604;5584.218209450762;4517.954820451753;5263.815641480789;5484.451554844483;5490.725463726718;5492.725363731717 10:05:29 INFO - PROCESS | 1643 | |5;yui.html;716.3159182980256;732.7801659502148;769.3153093746566;812.1229072601591;815.8327542853716;14789.334479948402;15407.922960385196;15480.303386347614;15517.689646207084;15939;11872.82190767137;14539.49111781088;14658.48695295665;14813.703725925476;14824.036437631547;837.6523742646795;854.5599016506504;859.5873980489368;859.8452278589851;862.7282406042108;679.2087218390594;856.8971723393202;864.1229152410309;866.2247288676631;866.6836604639293;731.0204326202887;740.3706849178209;885.2873436883307;911.5624500239888;918.347972939214;736.4219088015908;902.9345372460494;904.8054668246293;907.3875134284332;909.0137201136807;565.3244372974298;673.3939454490949;676.6075676107846;676.6210921883761;677.3903486861815;10586.735331616694;12074.637760867188;12506.687332816662;12517.248965062034;12751.61745147647;13288;14472.348744306531;14707.779383309258;14724.779128313085;14750.852491475056;11722;11764.882351176464;11836.467358968866;11865.644030679094;12186.939065304705;3676.2647470506004;3707.277080969212;3767.6232376762377;3802.2775672622115;3912.5500567434824;92110.07889921081;102789;105865.47067264614;109205.45397273042;111595;10936.343819370863;11034.889651103385;11202.103831693445;11735;11884.168108232514;19155.904220479086;23789.64315535268;24176.51646967086;24237.151699690425;24354.512909741705;7831.2560306770765;7868.567228802471;7870.763877083582;7983.800404989805;8117.310028647513;4022.939655905164;4159.625633692982;4266.31738921771;4356.607905288539;4419.1382680377665;3503.8948831535095;3534.134137136418;3544.6987006104255;3568.6074531801482;3578.0697018775304;639.309545690653;643.334149155631;656.9967150164218;659.8482349059743;666.8066260784318;672.7645324136513;673.515069150211;694.1323345817727;697.7488104282454;738.1142628845407;9850.852237216448;10069.647562335284;10241.180705543538;10352.327098738559;10464.26750127499;635.199648442956;684.3635419060322;699.4893727578794;719.3418022509345;724.9528780629242;4600.217962946307;4998.6750861193905;5001.299818025479;5017.2105465032955;5032.295478632995;97325;98323.50838245763;98431.50784246033;99427;101176;90933;92619.53690231506;93952;95118.0488195123;95618;63228.68385658042;80750.384992301;81460.59269703733;82312;83706;10025.749356266151;10844.945775271388;11027.22809403334;11045.337279762918;11248.943755281498;44305.33541996808;46370.768146159055;46834.76582617065;47014;47336.28995565138;58315;62812.37187628065;63373;67256.6637166811;68008.6599566999;11024.559017639205;12817.42321595549;12967;13294.800577991144;14035.929820350833;14598;14829;15012.849871501581;15255.923720381326;15746.685066298382;13144.934275328562;13253.271070090852;14178.787318190029;14260.928695356457;14409.207493587533;10924.781504370027;13657.863421366057;13868.375923083688;14280.857191427953;14320;12528.686782830502;13542.119762215425;13675.589732308046;13706.588802335946;14016.579502614937;10527.473626318806;10900.672979810619;11058.778824423305;11164.274322169033;11309.773804524028;9449.179772538218;9828.754281143028;10940.39827809478;11149.665510034712;11226.943865280622 10:05:29 INFO - PROCESS | 1643 | __end_tp_report 10:05:29 INFO - PROCESS | 1643 | __start_cc_report 10:05:29 INFO - PROCESS | 1643 | _x_x_mozilla_cycle_collect,1804 10:05:29 INFO - PROCESS | 1643 | __end_cc_report 10:05:29 INFO - PROCESS | 1643 | __startTimestamp1488737129280__endTimestamp 10:05:29 INFO - PROCESS | 1643 | 10:05:29 INFO - PROCESS | 1643 | ------- Summary: start ------- 10:05:29 INFO - PROCESS | 1643 | Number of tests: 6 10:05:29 INFO - PROCESS | 1643 | 10:05:29 INFO - PROCESS | 1643 | [#0] dojo.html Cycles:165 Average:5753.35 Median:6000.79 stddev:657.86 (11.0%) stddev-sans-first:630.69 10:05:29 INFO - PROCESS | 1643 | Values: 3283.3 3308.0 3336.3 3352.3 3386.3 5554.7 5641.0 5651.4 5654.7 5677.9 5586.0 5728.5 5741.5 5743.7 5791.8 5184.8 5223.9 5256.0 5260.4 5310.1 5191.6 5195.4 5309.6 5323.4 5360.6 5236.3 5246.7 5267.5 5280.0 5303.4 5271.2 5318.5 5327.7 5330.1 5339.1 5215.6 5252.2 5278.2 5285.0 5304.5 4677.5 5590.7 5635.9 5665.6 5679.4 6223.9 6244.5 6254.5 6277.0 6278.3 6248.8 6296.2 6305.0 6323.7 6329.7 5605.0 5714.8 5716.5 5832.7 5845.7 5252.4 6241.3 6288.0 6340.7 6359.2 6139.4 6198.6 6217.3 6234.1 6238.8 6166.4 6271.6 6299.2 6301.8 6306.9 5269.9 6131.2 6176.4 6197.6 6273.1 6280.0 6291.3 6291.8 6297.9 6308.1 4988.5 5035.6 5035.9 5036.3 5074.8 3712.9 4395.0 4410.3 4431.2 4439.8 5847.5 5878.9 5881.2 5904.1 5921.3 5123.5 6146.1 6202.9 6291.4 6295.8 5723.2 5782.7 5794.9 5803.2 5813.1 5440.6 5446.1 5449.2 5449.4 5458.8 6284.5 6303.2 6336.3 6383.1 6392.9 6164.8 6244.2 6254.2 6254.2 6276.3 6234.1 6259.2 6291.2 6292.4 6409.7 6248.1 6266.8 6289.4 6301.2 6303.1 6280.6 6284.9 6290.8 6295.3 6308.8 5998.1 6000.2 6053.3 6086.3 6110.2 6022.6 6151.6 6159.1 6171.4 6185.2 5969.9 6000.8 6011.4 6021.1 6023.8 6026.8 6067.0 6092.2 6104.6 6123.9 5993.8 6003.6 6008.2 6009.5 6016.1 10:05:29 INFO - PROCESS | 1643 | 10:05:29 INFO - PROCESS | 1643 | [#1] ext.html Cycles:180 Average:68651.38 Median:37709.03 stddev:148585.12 (394.0%) stddev-sans-first:148913.66 10:05:29 INFO - PROCESS | 1643 | Values: 429.7 446.2 502.8 513.2 513.3 26118.9 34597.7 40354.0 42411.4 44452.1 43590.8 43893.6 43897.8 43919.6 44152.8 8394.5 9164.5 9356.7 9367.9 9377.5 8443.5 11158.0 11389.7 11398.3 11596.5 11375.8 11480.7 11498.2 11512.5 11529.7 8425.2 11382.3 11432.7 11448.7 11471.8 8410.8 11033.9 11313.4 11324.5 11517.1 41480.0 41759.6 41765.2 41791.6 41812.2 3989.6 3997.9 4000.9 4013.8 4027.9 29416.9 29420.0 29489.1 30647.9 31017.0 3059.6 3176.9 3196.4 3238.7 3340.1 363773.0 363788.0 363864.0 364643.0 365603.0 63969.0 64102.7 64220.7 64255.7 64293.0 68710.3 68841.0 68863.3 68895.3 68966.0 16686.9 16961.1 16974.0 16976.2 16977.6 11774.0 12018.4 12725.5 12797.3 12834.2 17886.7 22323.9 22414.2 22921.9 22930.5 8111.8 8415.7 8766.2 8959.6 8968.1 872.9 900.6 904.8 926.6 942.3 30061.8 30425.2 30616.7 31305.1 31387.0 1046.2 1066.5 1082.2 1100.1 1107.5 15286.4 15822.9 15927.9 15944.4 16058.0 677212.0 681818.0 682678.0 682959.0 684532.0 47880.5 48229.8 48346.0 48383.8 48461.8 1438.7 1440.7 1465.8 1480.8 1481.8 28827.0 29935.0 30050.5 30393.8 30657.8 44336.0 53484.0 53791.7 53798.2 53879.2 570904.0 572333.0 573645.0 573791.0 574491.0 43298.4 43508.0 44032.8 44179.3 44277.0 47865.0 47873.5 48453.8 48935.0 49639.3 33182.7 33262.0 39490.6 39526.0 39818.8 37130.3 39104.4 39761.0 40469.4 40783.0 37358.4 37415.0 37621.8 37660.4 37757.6 33213.3 33873.8 34703.5 34741.0 34892.0 24256.8 24342.9 24838.0 25121.7 25499.6 10:05:29 INFO - PROCESS | 1643 | 10:05:29 INFO - PROCESS | 1643 | [#2] jquery.html Cycles:180 Average:34358.99 Median:14546.02 stddev:94970.77 (652.9%) stddev-sans-first:95202.86 10:05:29 INFO - PROCESS | 1643 | Values: 351.2 367.4 385.8 388.8 404.5 15442.5 16275.4 18036.9 20848.6 21356.6 17466.8 20478.7 21130.7 21744.7 21786.9 5154.4 5312.2 5312.9 5316.2 5604.4 4812.2 5905.1 5914.3 5923.9 5932.8 3888.5 4073.3 5675.8 5900.1 5928.7 5790.0 5941.2 6013.9 6043.9 6052.8 5830.0 5830.1 5836.6 5837.2 5838.5 13286.5 15562.8 26341.6 26454.9 26654.5 2577.3 2610.5 2637.1 2659.8 2689.6 9987.9 10049.3 10059.8 10559.2 10570.4 1736.2 1781.7 1784.8 1791.4 1807.2 100671.0 105054.9 120033.4 133504.7 135684.6 11737.3 11811.5 11926.7 12069.2 12428.6 13000.9 15940.4 15963.4 15990.4 15998.0 8641.8 8862.1 8874.2 9017.9 9025.2 8778.2 8786.4 8815.6 8929.2 8954.3 4668.6 4674.6 4765.1 4778.8 4841.0 1967.9 2001.1 2010.8 2010.8 2032.7 858.4 881.8 889.2 893.2 917.1 21252.5 22143.8 22145.7 22166.6 22214.1 886.5 902.9 905.4 916.3 919.2 8890.4 11401.7 12333.8 12365.9 12754.0 474193.0 568970.0 574015.0 600600.0 601247.0 107938.0 127240.4 131357.7 132661.0 136803.0 982.4 1032.8 1051.7 1055.2 1055.9 19386.5 19971.3 20003.8 20102.2 20154.9 50378.5 52669.0 56133.7 56656.0 56944.1 85536.7 86971.6 88488.0 89553.6 91089.6 6860.0 7712.7 7938.4 8328.8 8564.8 9233.3 12466.3 13111.4 13425.5 13722.6 9107.5 10002.9 11388.0 11391.6 11650.7 10934.2 11062.7 11305.8 11462.3 11526.8 10483.2 11398.7 11420.6 11795.9 11853.9 6602.3 7366.4 7510.2 7676.9 8434.5 10514.2 11084.2 11230.0 11435.1 11746.7 10:05:29 INFO - PROCESS | 1643 | 10:05:29 INFO - PROCESS | 1643 | [#3] mootools.html Cycles:180 Average:5319.72 Median:5210.43 stddev:2893.72 (55.5%) stddev-sans-first:2886.16 10:05:29 INFO - PROCESS | 1643 | Values: 1311.8 1447.0 1457.4 1465.2 1468.1 8026.9 8440.7 8443.8 8443.8 8444.3 6480.5 7419.8 7623.1 7640.3 8252.9 1924.2 2280.1 2333.2 2336.0 2341.5 2015.6 2228.0 2296.0 2332.8 2351.4 1906.3 2046.0 2083.2 2121.3 2231.5 2299.9 2316.7 2320.2 2320.3 2321.6 2257.6 2304.9 2321.5 2340.9 2342.5 8265.7 8348.0 8349.2 8350.2 8358.8 4078.8 5036.4 5203.2 5204.5 5216.4 3278.4 3434.8 3448.7 3495.5 3510.5 1127.7 1199.3 1201.1 1223.5 1233.1 10719.0 10744.7 10770.7 10774.4 10816.4 4506.8 4726.0 4733.7 4741.0 4792.3 7292.8 8603.1 8635.3 8643.5 8651.3 5136.6 5137.7 5138.8 5141.3 5146.9 4618.4 4734.6 4822.3 4825.0 4883.8 2992.9 3733.2 3750.1 3788.4 3793.6 1157.7 1157.8 1165.7 1170.5 1173.9 831.5 855.2 868.1 894.6 925.1 4744.4 5678.1 5812.7 5821.1 5971.9 952.6 958.3 960.0 988.5 1030.9 2998.8 3446.3 3461.6 3590.4 3602.9 9659.0 9949.0 9984.9 9991.4 9993.1 8358.3 9699.0 9943.3 9977.0 9978.5 7645.5 7755.1 7762.4 7793.2 7799.7 5511.5 5658.9 5721.1 5910.7 5996.9 9056.7 9298.3 9303.6 9307.3 9369.3 6604.5 8540.5 8851.6 9306.4 9325.7 6736.4 6867.3 7013.6 7100.5 7190.9 7576.8 7910.1 7915.6 7939.4 8012.0 6963.6 7078.3 7170.3 7218.0 7326.6 6267.4 7087.2 7104.7 7132.5 7142.7 6320.4 6385.2 6400.8 6477.6 6478.1 4750.5 4756.3 4810.6 4843.5 4913.5 4507.3 4586.0 4794.1 4881.2 4922.5 10:05:29 INFO - PROCESS | 1643 | 10:05:29 INFO - PROCESS | 1643 | [#4] prototype.html Cycles:180 Average:4472.08 Median:4950.18 stddev:1400.84 (28.3%) stddev-sans-first:1370.17 10:05:29 INFO - PROCESS | 1643 | Values: 349.5 352.8 361.0 371.5 372.3 5195.2 5313.9 5314.9 5365.9 5373.8 4437.9 5017.8 5058.5 5160.6 5321.8 3721.4 3815.4 3944.3 3965.2 4142.0 3575.9 4024.7 4086.6 4119.2 4188.2 3258.8 3862.3 4012.0 4077.3 4147.7 3412.6 3807.2 3979.3 4025.6 4039.8 3002.8 3007.9 3457.4 3465.7 3467.7 3919.8 4728.7 4931.5 4945.9 5198.9 3579.9 4119.0 4207.7 4504.1 4555.0 4596.2 4615.9 5174.6 5565.9 5660.3 3151.8 3189.7 3747.9 3757.8 3802.8 5142.4 5537.8 5913.8 5968.5 6018.5 3818.2 3849.6 3849.7 3850.0 3864.5 3625.7 3776.7 3876.2 3911.0 3923.2 4128.6 4293.3 4519.3 4572.0 4583.4 5524.0 5655.6 5695.5 5707.0 5761.5 1164.5 1191.5 1202.5 1231.9 1240.3 793.6 820.2 824.8 827.8 829.9 4779.8 4948.9 4951.5 5156.0 5340.5 4647.7 5035.7 5825.9 5841.3 5877.9 4458.8 5220.8 5277.2 5337.3 5347.8 2518.6 2906.6 2934.5 2937.9 2942.3 5405.4 5756.5 5764.0 5800.9 5802.0 4687.6 5196.4 5475.1 5645.6 5711.5 4927.4 5358.4 5733.9 5769.3 5778.7 4561.6 4657.0 5501.6 5569.4 5781.8 4877.5 5673.7 5709.5 5748.8 5771.5 5602.0 5931.9 6053.2 6062.6 6068.9 3650.0 3905.7 4162.5 4237.0 4243.1 5814.7 5825.6 5854.2 5854.2 5862.8 4793.0 5535.9 5626.8 5696.0 5720.7 5062.8 5203.2 5625.5 5625.6 5638.4 4756.0 4847.3 5504.7 5528.8 5534.2 4424.6 5491.7 5498.9 5524.9 5584.2 4518.0 5263.8 5484.5 5490.7 5492.7 10:05:29 INFO - PROCESS | 1643 | 10:05:29 INFO - PROCESS | 1643 | [#5] yui.html Cycles:180 Average:20289.85 Median:3857.41 stddev:29070.63 (753.6%) stddev-sans-first:29115.03 10:05:29 INFO - PROCESS | 1643 | Values: 716.3 732.8 769.3 812.1 815.8 14789.3 15407.9 15480.3 15517.7 15939.0 11872.8 14539.5 14658.5 14813.7 14824.0 837.7 854.6 859.6 859.8 862.7 679.2 856.9 864.1 866.2 866.7 731.0 740.4 885.3 911.6 918.3 736.4 902.9 904.8 907.4 909.0 565.3 673.4 676.6 676.6 677.4 10586.7 12074.6 12506.7 12517.2 12751.6 13288.0 14472.3 14707.8 14724.8 14750.9 11722.0 11764.9 11836.5 11865.6 12186.9 3676.3 3707.3 3767.6 3802.3 3912.6 92110.1 102789.0 105865.5 109205.5 111595.0 10936.3 11034.9 11202.1 11735.0 11884.2 19155.9 23789.6 24176.5 24237.2 24354.5 7831.3 7868.6 7870.8 7983.8 8117.3 4022.9 4159.6 4266.3 4356.6 4419.1 3503.9 3534.1 3544.7 3568.6 3578.1 639.3 643.3 657.0 659.8 666.8 672.8 673.5 694.1 697.7 738.1 9850.9 10069.6 10241.2 10352.3 10464.3 635.2 684.4 699.5 719.3 725.0 4600.2 4998.7 5001.3 5017.2 5032.3 97325.0 98323.5 98431.5 99427.0 101176.0 90933.0 92619.5 93952.0 95118.0 95618.0 63228.7 80750.4 81460.6 82312.0 83706.0 10025.7 10844.9 11027.2 11045.3 11248.9 44305.3 46370.8 46834.8 47014.0 47336.3 58315.0 62812.4 63373.0 67256.7 68008.7 11024.6 12817.4 12967.0 13294.8 14035.9 14598.0 14829.0 15012.8 15255.9 15746.7 13144.9 13253.3 14178.8 14260.9 14409.2 10924.8 13657.9 13868.4 14280.9 14320.0 12528.7 13542.1 13675.6 13706.6 14016.6 10527.5 10900.7 11058.8 11164.3 11309.8 9449.2 9828.8 10940.4 11149.7 11226.9 10:05:29 INFO - PROCESS | 1643 | -------- Summary: end -------- 10:05:29 INFO - PROCESS | 1643 | 10:05:29 INFO - TEST-INFO | 1643: exit 0 10:05:29 INFO - TEST-OK | dromaeo_css | took 1118948ms 10:05:29 INFO - TEST-START | kraken 10:05:29 INFO - operating with platform_type : mac_ 10:05:29 INFO - Initialising browser for kraken test... 10:05:29 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpSjJjo6/profile http://localhost:49243/getInfo.html) 10:05:32 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 10:05:32 INFO - PROCESS | 1648 | colorDepth:24 10:05:32 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 10:05:32 INFO - PROCESS | 1648 | __metrics 10:05:32 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 10:05:32 INFO - PROCESS | 1648 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:05:32 INFO - TEST-INFO | 1648: exit 0 10:05:32 INFO - Browser initialized. 10:05:32 INFO - Running cycle 1/1 for kraken test... 10:05:32 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpSjJjo6/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:05:44 INFO - PROCESS | 1649 | RSS: Main: 212676608 10:05:44 INFO - PROCESS | 1649 | 10:05:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 10:05:48 INFO - PROCESS | 1649 | RSS: Main: 265142272 10:05:48 INFO - PROCESS | 1649 | 10:05:51 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 10:05:51 INFO - PROCESS | 1649 | RSS: Main: 274165760 10:05:51 INFO - PROCESS | 1649 | 10:05:54 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 10:05:55 INFO - PROCESS | 1649 | RSS: Main: 370737152 10:05:55 INFO - PROCESS | 1649 | 10:05:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 10:05:58 INFO - PROCESS | 1649 | RSS: Main: 276369408 10:05:58 INFO - PROCESS | 1649 | 10:06:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:06:00 INFO - PROCESS | 1649 | RSS: Main: 278425600 10:06:00 INFO - PROCESS | 1649 | 10:06:03 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 10:06:04 INFO - PROCESS | 1649 | RSS: Main: 317337600 10:06:04 INFO - PROCESS | 1649 | 10:06:07 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 10:06:07 INFO - PROCESS | 1649 | RSS: Main: 317878272 10:06:07 INFO - PROCESS | 1649 | 10:06:10 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 10:06:11 INFO - PROCESS | 1649 | RSS: Main: 314912768 10:06:11 INFO - PROCESS | 1649 | 10:06:12 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:06:13 INFO - PROCESS | 1649 | RSS: Main: 294309888 10:06:13 INFO - PROCESS | 1649 | 10:06:15 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:06:16 INFO - PROCESS | 1649 | RSS: Main: 298524672 10:06:16 INFO - PROCESS | 1649 | 10:06:18 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:06:18 INFO - PROCESS | 1649 | RSS: Main: 303034368 10:06:18 INFO - PROCESS | 1649 | 10:06:21 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:06:22 INFO - PROCESS | 1649 | RSS: Main: 316375040 10:06:22 INFO - PROCESS | 1649 | 10:06:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:06:25 INFO - PROCESS | 1649 | RSS: Main: 310734848 10:06:25 INFO - PROCESS | 1649 | 10:06:27 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 10:06:28 INFO - PROCESS | 1649 | RSS: Main: 354607104 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | __start_tp_report 10:06:28 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 10:06:28 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 10:06:28 INFO - PROCESS | 1649 | |i|pagename|runs| 10:06:28 INFO - PROCESS | 1649 | |0;ai-astar;114;113;112;111;110;113;111;113;112;112 10:06:28 INFO - PROCESS | 1649 | |1;audio-beat-detection;142;109;108;147;108;108;113;108;147;141 10:06:28 INFO - PROCESS | 1649 | |2;audio-dft;188;181;182;185;184;183;182;185;184;185 10:06:28 INFO - PROCESS | 1649 | |3;audio-fft;80;58;58;91;58;68;83;81;97;58 10:06:28 INFO - PROCESS | 1649 | |4;audio-oscillator;88;70;85;69;68;70;81;67;69;82 10:06:28 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;88;85;88;90;135;131;88;86;89;84 10:06:28 INFO - PROCESS | 1649 | |6;imaging-darkroom;95;95;95;94;94;94;95;95;94;95 10:06:28 INFO - PROCESS | 1649 | |7;imaging-desaturate;86;87;85;84;85;86;84;85;88;85 10:06:28 INFO - PROCESS | 1649 | |8;json-parse-financial;57;57;54;54;55;57;56;55;57;57 10:06:28 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;66;80;73;73;71;68;66;68;70;69 10:06:28 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;82;83;85;84;85;86;83;82;84;84 10:06:28 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;134;138;137;138;135;133;138;138;181;137 10:06:28 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;170;166;218;188;177;170;168;167;167;165 10:06:28 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;66;66;66;66;64;63;71;83;83;84 10:06:28 INFO - PROCESS | 1649 | __end_tp_report 10:06:28 INFO - PROCESS | 1649 | __start_cc_report 10:06:28 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2064 10:06:28 INFO - PROCESS | 1649 | __end_cc_report 10:06:28 INFO - PROCESS | 1649 | __startTimestamp1488737188005__endTimestamp 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | ------- Summary: start ------- 10:06:28 INFO - PROCESS | 1649 | Number of tests: 14 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.50 stddev:1.20 (1.1%) stddev-sans-first:1.05 10:06:28 INFO - PROCESS | 1649 | Values: 114.0 113.0 112.0 111.0 110.0 113.0 111.0 113.0 112.0 112.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:123.10 Median:127.00 stddev:18.36 (14.5%) stddev-sans-first:18.15 10:06:28 INFO - PROCESS | 1649 | Values: 142.0 109.0 108.0 147.0 108.0 108.0 113.0 108.0 147.0 141.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.50 stddev:2.02 (1.1%) stddev-sans-first:1.51 10:06:28 INFO - PROCESS | 1649 | Values: 188.0 181.0 182.0 185.0 184.0 183.0 182.0 185.0 184.0 185.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:73.20 Median:80.50 stddev:15.05 (18.7%) stddev-sans-first:15.76 10:06:28 INFO - PROCESS | 1649 | Values: 80.0 58.0 58.0 91.0 58.0 68.0 83.0 81.0 97.0 58.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:74.90 Median:75.50 stddev:8.09 (10.7%) stddev-sans-first:7.06 10:06:28 INFO - PROCESS | 1649 | Values: 88.0 70.0 85.0 69.0 68.0 70.0 81.0 67.0 69.0 82.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:88.00 stddev:19.40 (22.0%) stddev-sans-first:20.33 10:06:28 INFO - PROCESS | 1649 | Values: 88.0 85.0 88.0 90.0 135.0 131.0 88.0 86.0 89.0 84.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 10:06:28 INFO - PROCESS | 1649 | Values: 95.0 95.0 95.0 94.0 94.0 94.0 95.0 95.0 94.0 95.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:85.50 Median:85.50 stddev:1.27 (1.5%) stddev-sans-first:1.33 10:06:28 INFO - PROCESS | 1649 | Values: 86.0 87.0 85.0 84.0 85.0 86.0 84.0 85.0 88.0 85.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:57.00 stddev:1.29 (2.3%) stddev-sans-first:1.30 10:06:28 INFO - PROCESS | 1649 | Values: 57.0 57.0 54.0 54.0 55.0 57.0 56.0 55.0 57.0 57.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:70.40 Median:70.50 stddev:4.20 (6.0%) stddev-sans-first:4.14 10:06:28 INFO - PROCESS | 1649 | Values: 66.0 80.0 73.0 73.0 71.0 68.0 66.0 68.0 70.0 69.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.32 (1.6%) stddev-sans-first:1.22 10:06:28 INFO - PROCESS | 1649 | Values: 82.0 83.0 85.0 84.0 85.0 86.0 83.0 82.0 84.0 84.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:140.90 Median:138.00 stddev:14.21 (10.3%) stddev-sans-first:14.85 10:06:28 INFO - PROCESS | 1649 | Values: 134.0 138.0 137.0 138.0 135.0 133.0 138.0 138.0 181.0 137.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.60 Median:170.00 stddev:16.42 (9.7%) stddev-sans-first:17.29 10:06:28 INFO - PROCESS | 1649 | Values: 170.0 166.0 218.0 188.0 177.0 170.0 168.0 167.0 167.0 165.0 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.20 Median:68.50 stddev:8.63 (12.6%) stddev-sans-first:8.94 10:06:28 INFO - PROCESS | 1649 | Values: 66.0 66.0 66.0 66.0 64.0 63.0 71.0 83.0 83.0 84.0 10:06:28 INFO - PROCESS | 1649 | -------- Summary: end -------- 10:06:28 INFO - PROCESS | 1649 | 10:06:28 INFO - TEST-INFO | 1649: exit 0 10:06:28 INFO - TEST-OK | kraken | took 59031ms 10:06:28 INFO - SUITE-END | took 1177s 10:06:29 INFO - Completed test suite (00:19:38) 10:06:29 INFO - javascript benchmark 10:06:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.294091770269, 3308.0241328808, 3336.2826992196674, 3352.296017836254, 3386.2888793353395, 5554.722263886804, 5641.0, 5651.406602306755, 5654.717264136792, 5677.8580535486635, 5586.022446071942, 5728.455796699307, 5741.483266506014, 5743.684097374643, 5791.82624521264, 5184.792608295664, 5223.895522089556, 5256.001359741656, 5260.368755749297, 5310.070737620901, 5191.636585439021, 5195.350581177353, 5309.601779866506, 5323.441038690939, 5360.597955153359, 5236.266922630815, 5246.685198888079, 5267.47325267474, 5280.023195708787, 5303.363596368422, 5271.2356708277275, 5318.521333080042, 5327.706976116312, 5330.147176451749, 5339.145736682131, 5215.608829337815, 5252.159654455307, 5278.2082687596785, 5285.048691235576, 5304.496072873071, 4677.4854765975715, 5590.748416321276, 5635.8591035224445, 5665.603407761459, 5679.432056794329, 6223.937760622381, 6244.469220116295, 6254.499640028786, 6276.96861515694, 6278.277998030239, 6248.812535623939, 6296.244450665904, 6304.968475157641, 6323.715432805535, 6329.715162817684, 5604.971975140098, 5714.828555143353, 5716.485516303553, 5832.679202643811, 5845.707714614295, 5252.369715634072, 6241.344658810759, 6287.96856015717, 6340.714667839959, 6359.20509936258, 6139.3553676863285, 6198.597091189058, 6217.253929528486, 6234.064890266496, 6238.781642642576, 6166.445019948136, 6271.592346497463, 6299.244090709144, 6301.842453938688, 6306.873862522724, 5269.8933224023385, 6131.162586540582, 6176.413240742122, 6197.628142311476, 6273.0904018917, 6280.026595877646, 6291.339409362043, 6291.842703932438, 6297.905531416941, 6308.148399965946, 4988.501149884983, 5035.571976382049, 5035.949640503622, 5036.320096786887, 5074.797008119634, 3712.925741485155, 4395.033092719596, 4410.29435290352, 4431.180231657154, 4439.755813430293, 5847.473727364558, 5878.853028674317, 5881.206037184926, 5904.143899134688, 5921.348651648315, 5123.487651234846, 6146.108814222002, 6202.875942481125, 6291.402316779899, 6295.842603934847, 5723.227364305849, 5782.653040817564, 5794.884102318014, 5803.187553742479, 5813.069908814569, 5440.564754819605, 5446.101393270066, 5449.237106805051, 5449.373322067933, 5458.836234912959, 6284.465820405226, 6303.243610766737, 6336.334684858116, 6383.0744542042075, 6392.87214255703, 6164.815055548341, 6244.219472565929, 6254.24949006104, 6254.249490061222, 6276.340984196594, 6234.127222188807, 6259.217597800275, 6291.245050593958, 6292.370762923671, 6409.7115629795835, 6248.062790581449, 6266.843328916813, 6289.371062893674, 6301.243850737941, 6303.054541818764, 6280.591761535486, 6284.874302513833, 6290.779822706183, 6295.307516173309, 6308.810735677937, 5998.1002849572915, 6000.249968753906, 6053.334133245251, 6086.300075491198, 6110.175126357884, 6022.608530445507, 6151.630902145886, 6159.1069294951085, 6171.413715697002, 6185.195924529782, 5969.940300597113, 6000.789972350947, 6011.398860113954, 6021.096835474714, 6023.789167379121, 6026.849328766816, 6067.0, 6092.208012958287, 6104.633721976696, 6123.938760612336, 5993.790217342372, 6003.609765365237, 6008.218931538872, 6009.519238461, 6016.09758536223], "value": 5710.768450266403, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.71209289775845, 446.21020793196044, 502.8039064764742, 513.207095038166, 513.2839688634355, 26118.869405652968, 34597.654023459756, 40353.99115022122, 42411.363829542584, 44452.110957780824, 43590.78204608973, 43893.561064389425, 43897.78051109748, 43919.56080439195, 44152.77923610385, 8394.496330220176, 9164.541772911345, 9356.719298421025, 9367.906320936805, 9377.484238366887, 8443.451175673592, 11157.995780379764, 11389.658310250707, 11398.316101033965, 11596.53613855449, 11375.772484550303, 11480.71298217543, 11498.19512634116, 11512.539498420096, 11529.654110376701, 8425.199606037417, 11382.317060976367, 11432.714182145513, 11448.656540303804, 11471.827922581126, 8410.831783364298, 11033.889661103447, 11313.434328283634, 11324.547018119265, 11517.078633709367, 41480.0, 41759.582404175875, 41765.1646967059, 41791.58208417907, 41812.163756724694, 3989.5611482736876, 3997.8600748973645, 4000.899977500586, 4013.779242141681, 4027.8791636250958, 29416.852915735497, 29419.97030103936, 29489.11532654024, 30647.927322543826, 31017.0, 3059.6481404638307, 3176.872925082994, 3196.360727854415, 3238.724708399789, 3340.148262193125, 363773.0, 363788.0, 363864.0, 364643.0, 365603.0, 63969.0, 64102.6794866032, 64220.67889660615, 64255.67872160703, 64293.0, 68710.31289687139, 68841.0, 68863.3113668857, 68895.3110468899, 68966.0, 16686.91535050218, 16961.0671413071, 16974.0, 16976.236069376908, 16977.575560610836, 11774.0, 12018.399080045963, 12725.490980360866, 12797.29614871191, 12834.229946203071, 17886.683870378547, 22323.888380558317, 22414.215502457337, 22921.88539057294, 22930.541389172122, 8111.837763244702, 8415.747527574182, 8766.21104100634, 8959.641614335354, 8968.05835387288, 872.8734333521604, 900.6352427266968, 904.8054668246227, 926.5691453474167, 942.3356533643764, 30061.849690751405, 30425.239369015508, 30616.69383306183, 31305.06084817459, 31387.0, 1046.1578429364283, 1066.5040756048475, 1082.242430298794, 1100.070440477795, 1107.5293000474767, 15286.38854445832, 15822.92088539573, 15927.920360398124, 15944.36222551085, 16057.956232845061, 677212.0, 681818.0, 682678.0, 682959.0, 684532.0, 47880.5211947883, 48229.75885120552, 48346.0, 48383.758081209366, 48461.75769121132, 1438.7293017614586, 1440.7046555456106, 1465.7508223602013, 1480.7556753135611, 1481.7703255995339, 28827.0, 29935.0, 30050.54924176183, 30393.84630753407, 30657.846710767197, 44336.0, 53484.0, 53791.731041344545, 53798.19302710384, 53879.19181212363, 570904.0, 572333.0, 573645.0, 573791.0, 574491.0, 43298.36131095174, 43508.0, 44032.77983610061, 44179.33730994102, 44277.0, 47865.0, 47873.521264786905, 48453.75773121112, 48935.04259829709, 49639.25541116814, 33182.66817331796, 33262.0, 39490.605093948696, 39526.0, 39818.80090599528, 37130.257394852495, 39104.41343379908, 39761.0, 40469.39295910505, 40783.0, 37358.439623405124, 37415.0, 37621.81189094037, 37660.43509347417, 37757.622423775414, 33213.33573328568, 33873.830630846685, 34703.4794478078, 34740.957771266905, 34891.9532414028, 24256.757432426155, 24342.878285608458, 24838.0, 25121.748782512674, 25499.6175057378], "value": 20650.384809729458, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.16247749118355, 367.3901323802488, 385.7723942873704, 388.76091203909596, 404.49236208558256, 15442.459513917016, 16275.430359937405, 18036.909815450905, 20848.58302833946, 21356.57286854262, 17466.825331746677, 20478.692819607717, 21130.683039754378, 21744.673829892563, 21786.89106554465, 5154.433012368646, 5312.150055991042, 5312.867178320535, 5316.175992721134, 5604.439556044404, 4812.205986012304, 5905.084711869667, 5914.290285165786, 5923.940760592403, 5932.822015339547, 3888.5223615026252, 4073.287174744408, 5675.801346952858, 5900.144479050535, 5928.703564821742, 5790.0, 5941.187937679007, 6013.939860601382, 6043.879122417549, 6052.848678783043, 5830.038043722823, 5830.067189249699, 5836.649801011953, 5837.241158649348, 5838.532917366643, 13286.468541258339, 15562.766558501631, 26341.604875926878, 26454.941802327885, 26654.46691066187, 2577.2912449076466, 2610.5040042391884, 2637.103384849141, 2659.8404095754317, 2689.5696688529742, 9987.90012099877, 10049.34679245854, 10059.849102263472, 10559.208059395576, 10570.365778053341, 1736.2013473802067, 1781.6792977264088, 1784.7590575272432, 1791.4177892185091, 1807.2409587973084, 100671.0, 105054.94945050604, 120033.39983300028, 133504.6649533502, 135684.5726170952, 11737.295762254293, 11811.468483918245, 11926.701832454084, 12069.189621556836, 12428.62714118578, 13000.934995324962, 15940.362385504683, 15963.361465541248, 15990.36038558468, 15998.0, 8641.783955401166, 8862.069482704352, 8874.201321881063, 9017.864732029026, 9025.187733104052, 8778.209961103532, 8786.42888212277, 8815.559222038872, 8929.151730585583, 8954.2836573074, 4668.5798278155125, 4674.555917187861, 4765.11845308619, 4778.761061946958, 4840.951590484121, 1967.852411069147, 2001.128944436956, 2010.8089731475486, 2010.839132869367, 2032.664610339307, 858.390542714667, 881.8456770065213, 889.226373055446, 893.2095095840228, 917.1104029091771, 21252.468688282916, 22143.77856221417, 22145.66781498279, 22166.556668866855, 22214.11143554272, 886.499127992682, 902.9413088149249, 905.4114825363434, 916.3310783128354, 919.2278486071732, 8890.421777684529, 11401.657950261506, 12333.814992775115, 12365.938170309091, 12753.979681625447, 474193.0, 568970.0, 574015.0, 600600.0, 601247.0, 107938.0, 127240.36379818227, 131357.68642313455, 132661.0, 136803.0, 982.3614650477247, 1032.8347464405658, 1051.6844946516014, 1055.1506037639774, 1055.889131641182, 19386.51533711612, 19971.301004464774, 20003.799962000194, 20102.195912163348, 20154.899225503777, 50378.496215038846, 52669.0, 56133.71933140308, 56656.0, 56944.14583781164, 85536.71694924457, 86971.56514217389, 88488.0, 89553.55223223842, 91089.63365549655, 6859.965700171467, 7712.72739997894, 7938.404619653665, 8328.791780205544, 8564.828703425772, 9233.307501937516, 12466.252024878173, 13111.409986550438, 13425.462981480632, 13722.588322349946, 9107.453552786854, 10002.899971000197, 11388.032017278292, 11391.601293954673, 11650.6504804856, 10934.179936504635, 11062.668119956414, 11305.7738845221, 11462.312261264351, 11526.769464610828, 10483.213758967955, 11398.658040258806, 11420.600278990196, 11795.941020294844, 11853.940730296294, 6602.273749887412, 7366.373858221897, 7510.173880872991, 7676.884846727192, 8434.451760635538, 10514.211434142622, 11084.168687348643, 11230.045446136843, 11435.085193184359, 11746.706332341419], "value": 9586.583890759635, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.7769979103552, 1446.9710605787884, 1457.387897083225, 1465.223431581262, 1468.1338010573759, 8026.9197308026905, 8440.704575339865, 8443.83112337753, 8443.831123377537, 8444.28223600993, 6480.546361754679, 7419.814504637387, 7623.123340815808, 7640.274173953466, 8252.91747082529, 1924.191839427444, 2280.076568989562, 2333.2183718454253, 2335.988320058406, 2341.508283260517, 2015.629372027021, 2228.0308065991344, 2296.0, 2332.8133749300014, 2351.3886389538757, 1906.332783525762, 2045.9897700511476, 2083.2292051940726, 2121.2999710095633, 2231.5313784105356, 2299.9425014374606, 2316.745158032615, 2320.153144102399, 2320.33870346952, 2321.58211521926, 2257.645412752352, 2304.884755762222, 2321.5124823787023, 2340.8595484271, 2342.5314937012495, 8265.669373225064, 8347.998240211153, 8349.206825351643, 8350.164983501601, 8358.791030224233, 4078.796060197008, 5036.420811606676, 5203.19350500673, 5204.479552044765, 5216.37403511581, 3278.4263553494216, 3434.7767395119236, 3448.6723761242642, 3495.458203978362, 3510.4558793387064, 1127.7011591928062, 1199.2804317409573, 1201.1111777284746, 1223.5350566784655, 1233.0813543909844, 10719.0, 10744.677659670222, 10770.676879693621, 10774.407407592658, 10816.405097719622, 4506.842260520866, 4726.0, 4733.692309999839, 4740.95259047412, 4792.329073929653, 7292.8176795579475, 8603.053664096944, 8635.266002389742, 8643.481391116553, 8651.264642505457, 5136.614753893473, 5137.691738495628, 5138.820141295037, 5141.305923700253, 5146.871328216825, 4618.399608050931, 4734.573888349996, 4822.300766388854, 4825.0, 4883.755812209375, 2992.940141197164, 3733.178700685845, 3750.1187221003042, 3788.431735239736, 3793.5827059023486, 1157.6932112990064, 1157.8089615213396, 1165.7435364219857, 1170.455738081796, 1173.9471723772451, 831.4803247970019, 855.1961156512858, 868.1188593577398, 894.6019021535354, 925.0703043441433, 4744.383230180055, 5678.14827775837, 5812.738426770806, 5821.126830975388, 5971.880562388728, 952.618952419024, 958.3100167879115, 959.9616015359447, 988.4761076629397, 1030.8659874216303, 2998.8200707957594, 3446.2590543033366, 3461.6365281645567, 3590.4075827488696, 3602.8759186685497, 9659.0, 9948.950255248677, 9984.900150998543, 9991.350562213433, 9993.050660187417, 8358.331333493306, 9698.981606931311, 9943.25425593069, 9976.950115249523, 9978.501074946224, 7645.503042302233, 7755.108162561265, 7762.379009679212, 7793.18171591986, 7799.688012479551, 5511.476409741068, 5658.886822263614, 5721.05602575587, 5910.749676755863, 5996.940030599638, 9056.728298151065, 9298.302627302844, 9303.581338839904, 9307.255419566283, 9369.297302702189, 6604.471642268511, 8540.487570745776, 8851.645934162561, 9306.441613503212, 9325.720228393158, 6736.427403670743, 6867.278935711678, 7013.649317534205, 7100.502964792415, 7190.89213661785, 7576.772696819105, 7910.090339611018, 7915.643796029308, 7939.444238903452, 8011.959940200495, 6963.582185068912, 7078.256783037707, 7170.318819712119, 7218.0, 7326.597037162794, 6267.4045965633195, 7087.220405755466, 7104.715811367488, 7132.536385134949, 7142.678579464041, 6320.4311611955145, 6385.201849768779, 6400.775972840928, 6477.611343319416, 6478.093066970534, 4750.477447480705, 4756.310335001336, 4810.5670489656095, 4843.457850976738, 4913.508649135058, 4507.346434766875, 4585.991081961963, 4794.089123066607, 4881.170201065898, 4922.507749225192], "value": 4329.907416581572, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.501959707417, 352.8006676227931, 360.9639036096391, 371.45952638910387, 372.2926439764449, 5195.168772996321, 5313.910648317091, 5314.9468505315035, 5365.919511207335, 5373.785048598052, 4437.866863994085, 5017.824376146836, 5058.494150584939, 5160.561352285051, 5321.840344789653, 3721.423179407196, 3815.389537673973, 3944.3097457944887, 3965.2441553120593, 4142.0473291143135, 3575.910602234952, 4024.6611586750837, 4086.570910054446, 4119.176164767058, 4188.183304255671, 3258.804471731704, 3862.2854771867296, 4011.9598804012026, 4077.2660921034203, 4147.688923330762, 3412.5734283214597, 3807.200487897545, 3979.263836190314, 4025.557188709254, 4039.838406463738, 3002.8439050965535, 3007.9248018799485, 3457.429524128516, 3465.7227421806447, 3467.711310535035, 3919.8040097994985, 4728.692634978715, 4931.5315045070665, 4945.901081978376, 5198.9448230379985, 3579.8926032219074, 4119.0, 4207.684423668237, 4504.09918016398, 4554.950272377443, 4596.172688915994, 4615.861524154281, 5174.560162386202, 5565.9443405565835, 5660.29246344207, 3151.8266495342746, 3189.7448204143843, 3747.8943711605143, 3757.7745335279697, 3802.7718336899875, 5142.408623008327, 5537.750801213915, 5913.758110796694, 5968.522518198533, 6018.479189674046, 3818.1790914952862, 3849.615038496128, 3849.711271654637, 3850.0374906273432, 3864.516935383077, 3625.6736893679695, 3776.6789822864816, 3876.244132394156, 3911.002694312932, 3923.156521347924, 4128.587141285848, 4293.325603014827, 4519.254323036728, 4571.954280457153, 4583.449986001701, 5524.038966167033, 5655.557832752704, 5695.45893140151, 5707.0, 5761.53907687384, 1164.5400066973668, 1191.4876603060768, 1202.4588934979295, 1231.946685583831, 1240.34881687115, 793.595266414133, 820.2248874813245, 824.7773101262745, 827.8096037911314, 829.8796674482167, 4779.784909679072, 4948.857475503081, 4951.504849515091, 5156.0, 5340.492653198017, 4647.697899636512, 5035.697858128524, 5825.912611310834, 5841.328247251536, 5877.882442351129, 4458.7547684877645, 5220.825314304251, 5277.23480095384, 5337.306150200449, 5347.82347883465, 2518.6222066690143, 2906.6193558059754, 2934.457125431802, 2937.911862644124, 2942.29384947611, 5405.378678124849, 5756.539476841843, 5764.0, 5800.941990580124, 5801.969310741291, 4687.5781179693995, 5196.402413722471, 5475.123980163155, 5645.633033852787, 5711.457411545896, 4927.43334516528, 5358.383785864676, 5733.885322293614, 5769.278840144982, 5778.653280803165, 4561.589456948891, 4657.0, 5501.642393244426, 5569.438058493139, 5781.82654520365, 4877.512248775094, 5673.687947162945, 5709.54323654115, 5748.809410776892, 5771.538276937918, 5602.01712559609, 5931.881362372815, 6053.243344581927, 6062.605930614496, 6068.936561569088, 3649.9817500912327, 3905.7070719695566, 4162.4796900387455, 4236.978815105905, 4243.130158317475, 5814.651120932757, 5825.592208545361, 5854.151148083419, 5854.151148083589, 5862.7654893805475, 4792.993471371051, 5535.944640553543, 5626.774929002794, 5695.971520142372, 5720.685362305113, 5062.848114556569, 5203.245529398292, 5625.549956003428, 5625.634333768292, 5638.351589567253, 4755.976220118877, 4847.321375007572, 5504.7155430495895, 5528.783667593123, 5534.1975413564005, 4424.619626569737, 5491.697956612425, 5498.890022199454, 5524.944750552604, 5584.218209450762, 4517.954820451753, 5263.815641480789, 5484.451554844483, 5490.725463726718, 5492.725363731717], "value": 4036.5375567256156, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [716.3159182980256, 732.7801659502148, 769.3153093746566, 812.1229072601591, 815.8327542853716, 14789.334479948402, 15407.922960385196, 15480.303386347614, 15517.689646207084, 15939.0, 11872.82190767137, 14539.49111781088, 14658.48695295665, 14813.703725925476, 14824.036437631547, 837.6523742646795, 854.5599016506504, 859.5873980489368, 859.8452278589851, 862.7282406042108, 679.2087218390594, 856.8971723393202, 864.1229152410309, 866.2247288676631, 866.6836604639293, 731.0204326202887, 740.3706849178209, 885.2873436883307, 911.5624500239888, 918.347972939214, 736.4219088015908, 902.9345372460494, 904.8054668246293, 907.3875134284332, 909.0137201136807, 565.3244372974298, 673.3939454490949, 676.6075676107846, 676.6210921883761, 677.3903486861815, 10586.735331616694, 12074.637760867188, 12506.687332816662, 12517.248965062034, 12751.61745147647, 13288.0, 14472.348744306531, 14707.779383309258, 14724.779128313085, 14750.852491475056, 11722.0, 11764.882351176464, 11836.467358968866, 11865.644030679094, 12186.939065304705, 3676.2647470506004, 3707.277080969212, 3767.6232376762377, 3802.2775672622115, 3912.5500567434824, 92110.07889921081, 102789.0, 105865.47067264614, 109205.45397273042, 111595.0, 10936.343819370863, 11034.889651103385, 11202.103831693445, 11735.0, 11884.168108232514, 19155.904220479086, 23789.64315535268, 24176.51646967086, 24237.151699690425, 24354.512909741705, 7831.2560306770765, 7868.567228802471, 7870.763877083582, 7983.800404989805, 8117.310028647513, 4022.939655905164, 4159.625633692982, 4266.31738921771, 4356.607905288539, 4419.1382680377665, 3503.8948831535095, 3534.134137136418, 3544.6987006104255, 3568.6074531801482, 3578.0697018775304, 639.309545690653, 643.334149155631, 656.9967150164218, 659.8482349059743, 666.8066260784318, 672.7645324136513, 673.515069150211, 694.1323345817727, 697.7488104282454, 738.1142628845407, 9850.852237216448, 10069.647562335284, 10241.180705543538, 10352.327098738559, 10464.26750127499, 635.199648442956, 684.3635419060322, 699.4893727578794, 719.3418022509345, 724.9528780629242, 4600.217962946307, 4998.6750861193905, 5001.299818025479, 5017.2105465032955, 5032.295478632995, 97325.0, 98323.50838245763, 98431.50784246033, 99427.0, 101176.0, 90933.0, 92619.53690231506, 93952.0, 95118.0488195123, 95618.0, 63228.68385658042, 80750.384992301, 81460.59269703733, 82312.0, 83706.0, 10025.749356266151, 10844.945775271388, 11027.22809403334, 11045.337279762918, 11248.943755281498, 44305.33541996808, 46370.768146159055, 46834.76582617065, 47014.0, 47336.28995565138, 58315.0, 62812.37187628065, 63373.0, 67256.6637166811, 68008.6599566999, 11024.559017639205, 12817.42321595549, 12967.0, 13294.800577991144, 14035.929820350833, 14598.0, 14829.0, 15012.849871501581, 15255.923720381326, 15746.685066298382, 13144.934275328562, 13253.271070090852, 14178.787318190029, 14260.928695356457, 14409.207493587533, 10924.781504370027, 13657.863421366057, 13868.375923083688, 14280.857191427953, 14320.0, 12528.686782830502, 13542.119762215425, 13675.589732308046, 13706.588802335946, 14016.579502614937, 10527.473626318806, 10900.672979810619, 11058.778824423305, 11164.274322169033, 11309.773804524028, 9449.179772538218, 9828.754281143028, 10940.39827809478, 11149.665510034712, 11226.943865280622], "value": 7489.170458427194, "unit": "score"}], "name": "dromaeo_css", "value": 7272.933968400286, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 112.0, 111.0, 110.0, 113.0, 111.0, 113.0, 112.0, 112.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 108.0, 147.0, 108.0, 108.0, 113.0, 108.0, 147.0, 141.0], "value": 123.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 181.0, 182.0, 185.0, 184.0, 183.0, 182.0, 185.0, 184.0, 185.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 58.0, 58.0, 91.0, 58.0, 68.0, 83.0, 81.0, 97.0, 58.0], "value": 73.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 85.0, 69.0, 68.0, 70.0, 81.0, 67.0, 69.0, 82.0], "value": 74.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 90.0, 135.0, 131.0, 88.0, 86.0, 89.0, 84.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 95.0], "value": 94.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 85.0, 84.0, 85.0, 86.0, 84.0, 85.0, 88.0, 85.0], "value": 85.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 54.0, 54.0, 55.0, 57.0, 56.0, 55.0, 57.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 80.0, 73.0, 73.0, 71.0, 68.0, 66.0, 68.0, 70.0, 69.0], "value": 70.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 85.0, 84.0, 85.0, 86.0, 83.0, 82.0, 84.0, 84.0], "value": 83.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 138.0, 137.0, 138.0, 135.0, 133.0, 138.0, 138.0, 181.0, 137.0], "value": 140.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 166.0, 218.0, 188.0, 177.0, 170.0, 168.0, 167.0, 167.0, 165.0], "value": 175.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 64.0, 63.0, 71.0, 83.0, 83.0, 84.0], "value": 71.2, "unit": "score"}], "name": "kraken", "value": 1441.5, "alertThreshold": 2.0}]} 10:06:29 INFO - Return code: 0 10:06:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:06:29 ERROR - # TBPL SUCCESS # 10:06:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:06:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:06:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:06:29 INFO - 2017-03-05 10:06:29.297 screenresolution[1653:10405] starting screenresolution argv=screenresolution get 10:06:29 INFO - 2017-03-05 10:06:29.299 screenresolution[1653:10405] Display 0: 1600x1200x32@60 10:06:29 INFO - 2017-03-05 10:06:29.306 screenresolution[1654:10408] starting screenresolution argv=screenresolution list 10:06:29 INFO - Available Modes on Display 0 10:06:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:06:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:06:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:06:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:06:29 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:06:29 INFO - Intel Iris: 10:06:29 INFO - Chipset Model: Intel Iris 10:06:29 INFO - Type: GPU 10:06:29 INFO - Bus: Built-In 10:06:29 INFO - VRAM (Dynamic, Max): 1536 MB 10:06:29 INFO - Vendor: Intel (0x8086) 10:06:29 INFO - Device ID: 0x0a2e 10:06:29 INFO - Revision ID: 0x0009 10:06:29 INFO - Displays: 10:06:29 INFO - Display: 10:06:29 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:06:29 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:06:29 INFO - Display Serial Number: 1600x1200 60 10:06:29 INFO - Main Display: Yes 10:06:29 INFO - Mirror: Off 10:06:29 INFO - Online: Yes 10:06:29 INFO - Rotation: Supported 10:06:29 INFO - Return code: 0 10:06:29 INFO - Running post-action listener: _resource_record_post_action 10:06:29 INFO - [mozharness: 2017-03-05 18:06:29.544282Z] Finished run-tests step (success) 10:06:29 INFO - Running post-run listener: _resource_record_post_run 10:06:29 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 32406528; Write bytes: 506565120; Read time: 190; Write time: 1584 10:06:29 INFO - TinderboxPrint: CPU usage
53.5% 10:06:29 INFO - TinderboxPrint: I/O read bytes / time
32,406,528 / 190 10:06:29 INFO - TinderboxPrint: I/O write bytes / time
506,565,120 / 1,584 10:06:29 INFO - TinderboxPrint: CPU idle
2,227.9 (46.5%) 10:06:29 INFO - TinderboxPrint: CPU system
956.8 (20.0%) 10:06:29 INFO - TinderboxPrint: CPU user
1,609.0 (33.6%) 10:06:29 INFO - TinderboxPrint: Swap in / out
236,204,032 / 0 10:06:29 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205683200; Write bytes: 200755200; Read time: 15622; Write time: 456 10:06:29 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 28814336; Write bytes: 294697472; Read time: 168; Write time: 1091 10:06:30 INFO - Running post-run listener: _upload_blobber_files 10:06:30 INFO - Blob upload gear active. 10:06:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:06:30 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 10:06:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:06:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:06:30 INFO - (blobuploader) - INFO - Open directory for files ... 10:06:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 10:06:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 10:06:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:31 INFO - (blobuploader) - INFO - Done attempting. 10:06:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 10:06:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 10:06:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:32 INFO - (blobuploader) - INFO - Done attempting. 10:06:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 10:06:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:33 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 10:06:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:33 INFO - (blobuploader) - INFO - Done attempting. 10:06:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:06:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:06:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:06:35 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:06:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:06:35 INFO - (blobuploader) - INFO - Done attempting. 10:06:35 INFO - (blobuploader) - INFO - Iteration through files over. 10:06:35 INFO - Return code: 0 10:06:35 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:06:35 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:06:35 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad365baae6d969ee1d955fcfd8d26770e9af655d7fb62e097a1293e21592f65c26d4760c9ee71f874da34042c10ac839b77305140f7df282782f66870f139e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d0bcb94b6f3d53ead788d89811506ca49d98e5d3a8ba19dd19b2b4730b081d026a7d2e073b4cd0caced6f77a7818847d35db0254b4e10b2136e1d6312cbde1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec9e9e2a367921dea765c32010328ebad4e511d0f7fc2da81b826c6d256c257f7998d17a79616cef363bfbb5d008fad34419c2c61ef0a18d9bd342b254c4265c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2092e197170fb7715cbe996a4f8354feeef48e1c7f51a0b3464aaa87a56fffa0b598bcd308be110d45e235bf46e692266b07405d961b85810a4e03b0cd8511e"} 10:06:35 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:06:35 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:06:35 INFO - Contents: 10:06:35 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad365baae6d969ee1d955fcfd8d26770e9af655d7fb62e097a1293e21592f65c26d4760c9ee71f874da34042c10ac839b77305140f7df282782f66870f139e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d0bcb94b6f3d53ead788d89811506ca49d98e5d3a8ba19dd19b2b4730b081d026a7d2e073b4cd0caced6f77a7818847d35db0254b4e10b2136e1d6312cbde1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec9e9e2a367921dea765c32010328ebad4e511d0f7fc2da81b826c6d256c257f7998d17a79616cef363bfbb5d008fad34419c2c61ef0a18d9bd342b254c4265c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2092e197170fb7715cbe996a4f8354feeef48e1c7f51a0b3464aaa87a56fffa0b598bcd308be110d45e235bf46e692266b07405d961b85810a4e03b0cd8511e"} 10:06:35 INFO - Running post-run listener: copy_logs_to_upload_dir 10:06:35 INFO - Copying logs to upload dir... 10:06:35 INFO - mkdir: /builds/slave/test/build/upload/logs 10:06:35 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.152454 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-05 10:06:35.522879) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 10:06:35.528878) ========= 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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad365baae6d969ee1d955fcfd8d26770e9af655d7fb62e097a1293e21592f65c26d4760c9ee71f874da34042c10ac839b77305140f7df282782f66870f139e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d0bcb94b6f3d53ead788d89811506ca49d98e5d3a8ba19dd19b2b4730b081d026a7d2e073b4cd0caced6f77a7818847d35db0254b4e10b2136e1d6312cbde1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec9e9e2a367921dea765c32010328ebad4e511d0f7fc2da81b826c6d256c257f7998d17a79616cef363bfbb5d008fad34419c2c61ef0a18d9bd342b254c4265c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2092e197170fb7715cbe996a4f8354feeef48e1c7f51a0b3464aaa87a56fffa0b598bcd308be110d45e235bf46e692266b07405d961b85810a4e03b0cd8511e"} build_url:https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/TzsmjottSNaU1xys6uo-Zw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ad365baae6d969ee1d955fcfd8d26770e9af655d7fb62e097a1293e21592f65c26d4760c9ee71f874da34042c10ac839b77305140f7df282782f66870f139e5c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9d0bcb94b6f3d53ead788d89811506ca49d98e5d3a8ba19dd19b2b4730b081d026a7d2e073b4cd0caced6f77a7818847d35db0254b4e10b2136e1d6312cbde1b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ec9e9e2a367921dea765c32010328ebad4e511d0f7fc2da81b826c6d256c257f7998d17a79616cef363bfbb5d008fad34419c2c61ef0a18d9bd342b254c4265c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2092e197170fb7715cbe996a4f8354feeef48e1c7f51a0b3464aaa87a56fffa0b598bcd308be110d45e235bf46e692266b07405d961b85810a4e03b0cd8511e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 10:06:35.563206) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 10:06:35.563554) ========= 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.DqEIzJwKjF/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.sGbzSOf1a6/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.005246 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 10:06:35.612423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 10:06:35.612736) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 10:06:35.613060) ========= ========= Total master_lag: 0.18 =========