builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0309 starttime: 1475812927.26 results: success (0) buildid: 20161006183603 builduid: 5072ec1740844f6093a01e8a131a5d1f revision: 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:07.258138) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:07.258609) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:07.259189) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:07.864802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:07.865265) ========= 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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-06 21:02:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.2M=0.001s 2016-10-06 21:02:08 (15.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.581753 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:08.513975) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:08.514290) ========= 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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.026652 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:08.575312) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:08.575648) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 --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 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZRYgs5H3W3/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.hFJBcUgWno/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-06 21:02:08,663 truncating revision to first 12 chars 2016-10-06 21:02:08,663 Setting DEBUG logging. 2016-10-06 21:02:08,663 attempt 1/10 2016-10-06 21:02:08,664 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/6eefe948a169?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-06 21:02:09,304 unpacking tar archive at: mozilla-aurora-6eefe948a169/testing/mozharness/ program finished with exit code 0 elapsedTime=0.923173 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:09.528385) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:09.528715) ========= script_repo_revision: 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:09.529186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:09.529481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-06 21:02:09.557663) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-06 21:02:09.557951) ========= /tools/buildbot/bin/python 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', '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:02:09 INFO - MultiFileLogger online at 20161006 21:02:09 in /builds/slave/test 21:02:09 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 21:02:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:02:09 INFO - {'append_to_log': False, 21:02:09 INFO - 'base_work_dir': '/builds/slave/test', 21:02:09 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 21:02:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:02:09 INFO - 'branch': 'Mozilla-Aurora', 21:02:09 INFO - 'buildbot_json_path': 'buildprops.json', 21:02:09 INFO - 'config_files': ('talos/mac_config.py',), 21:02:09 INFO - 'default_actions': ('clobber', 21:02:09 INFO - 'read-buildbot-config', 21:02:09 INFO - 'download-and-extract', 21:02:09 INFO - 'populate-webroot', 21:02:09 INFO - 'create-virtualenv', 21:02:09 INFO - 'install', 21:02:09 INFO - 'run-tests'), 21:02:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:02:09 INFO - 'download_minidump_stackwalk': True, 21:02:09 INFO - 'download_symbols': 'ondemand', 21:02:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:02:09 INFO - 'tooltool.py': '/tools/tooltool.py', 21:02:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:02:09 INFO - '/tools/misc-python/virtualenv.py')}, 21:02:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:02:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:02:09 INFO - 'installer_path': 'installer.exe', 21:02:09 INFO - 'log_level': 'info', 21:02:09 INFO - 'log_name': 'talos', 21:02:09 INFO - 'log_to_console': True, 21:02:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:02:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:02:09 INFO - 'opt_config_files': (), 21:02:09 INFO - 'pip_index': False, 21:02:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:02:09 INFO - 'cmd': ('bash', 21:02:09 INFO - '-c', 21:02:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:02:09 INFO - 'enabled': True, 21:02:09 INFO - 'halt_on_failure': False, 21:02:09 INFO - 'name': 'check_screen_resolution'},), 21:02:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:02:09 INFO - 'cmd': ('bash', 21:02:09 INFO - '-c', 21:02:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:02:09 INFO - 'enabled': True, 21:02:09 INFO - 'halt_on_failure': False, 21:02:09 INFO - 'name': 'check_screen_resolution'},), 21:02:09 INFO - 'run_cmd_checks_enabled': True, 21:02:09 INFO - 'sps_profile': False, 21:02:09 INFO - 'sps_profile_interval': 0, 21:02:09 INFO - 'suite': 'dromaeojs', 21:02:09 INFO - 'system_bits': '32', 21:02:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:02:09 INFO - 'title': 't-yosemite-r7-0309', 21:02:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:02:09 INFO - 'use_talos_json': True, 21:02:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:02:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:02:09 INFO - 'work_dir': 'build'} 21:02:09 INFO - [mozharness: 2016-10-07 04:02:09.752660Z] Running clobber step. 21:02:09 INFO - Running pre-action listener: _resource_record_pre_action 21:02:09 INFO - Running main action method: clobber 21:02:09 INFO - rmtree: /builds/slave/test/build 21:02:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:02:11 INFO - Running post-action listener: _resource_record_post_action 21:02:11 INFO - [mozharness: 2016-10-07 04:02:11.960729Z] Finished clobber step (success) 21:02:11 INFO - [mozharness: 2016-10-07 04:02:11.960849Z] Running read-buildbot-config step. 21:02:11 INFO - Running pre-action listener: _resource_record_pre_action 21:02:11 INFO - Running main action method: read_buildbot_config 21:02:11 INFO - Using buildbot properties: 21:02:11 INFO - { 21:02:11 INFO - "project": "", 21:02:11 INFO - "product": "firefox", 21:02:11 INFO - "script_repo_revision": "production", 21:02:11 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 21:02:11 INFO - "repository": "", 21:02:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 21:02:11 INFO - "buildid": "20161006183603", 21:02:11 INFO - "pgo_build": "False", 21:02:11 INFO - "basedir": "/builds/slave/test", 21:02:11 INFO - "buildnumber": 37, 21:02:11 INFO - "slavename": "t-yosemite-r7-0309", 21:02:11 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 21:02:11 INFO - "platform": "yosemite_r7", 21:02:11 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 21:02:11 INFO - "branch": "mozilla-aurora", 21:02:11 INFO - "repo_path": "releases/mozilla-aurora", 21:02:11 INFO - "revision": "6eefe948a16906fb0f4f9134ea75b52e0638c4f9", 21:02:11 INFO - "stage_platform": "macosx64", 21:02:11 INFO - "builduid": "5072ec1740844f6093a01e8a131a5d1f", 21:02:11 INFO - "slavebuilddir": "test" 21:02:11 INFO - } 21:02:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg. 21:02:11 INFO - Running post-action listener: _resource_record_post_action 21:02:11 INFO - [mozharness: 2016-10-07 04:02:11.964009Z] Finished read-buildbot-config step (success) 21:02:11 INFO - [mozharness: 2016-10-07 04:02:11.964136Z] Running download-and-extract step. 21:02:11 INFO - Running pre-action listener: _resource_record_pre_action 21:02:11 INFO - Running main action method: download_and_extract 21:02:11 INFO - mkdir: /builds/slave/test/build/tests 21:02:11 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')]} 21:02:11 INFO - trying https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json 21:02:11 INFO - Downloading https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json'}, attempt #1 21:02:13 INFO - Downloaded 1199 bytes. 21:02:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a2.en-US.mac.test_packages.json 21:02:13 INFO - Using the following test package requirements: 21:02:13 INFO - {u'common': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:02:13 INFO - u'cppunittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:02:13 INFO - u'firefox-51.0a2.en-US.mac.cppunittest.tests.zip'], 21:02:13 INFO - u'gtest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:02:13 INFO - u'firefox-51.0a2.en-US.mac.gtest.tests.zip'], 21:02:13 INFO - u'jittest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:02:13 INFO - u'jsshell-mac.zip'], 21:02:13 INFO - u'mochitest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:02:13 INFO - u'firefox-51.0a2.en-US.mac.mochitest.tests.zip'], 21:02:13 INFO - u'mozbase': [u'firefox-51.0a2.en-US.mac.common.tests.zip'], 21:02:13 INFO - u'reftest': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:02:13 INFO - u'firefox-51.0a2.en-US.mac.reftest.tests.zip'], 21:02:13 INFO - u'talos': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:02:13 INFO - u'firefox-51.0a2.en-US.mac.talos.tests.zip'], 21:02:13 INFO - u'web-platform': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:02:13 INFO - u'firefox-51.0a2.en-US.mac.web-platform.tests.zip'], 21:02:13 INFO - u'xpcshell': [u'firefox-51.0a2.en-US.mac.common.tests.zip', 21:02:13 INFO - u'firefox-51.0a2.en-US.mac.xpcshell.tests.zip']} 21:02:13 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip'] for test suite category: common 21:02:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:02:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:02:13 INFO - Fetch https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:02:13 INFO - Expected file size: 16434738 21:02:20 INFO - Downloading packages: [u'firefox-51.0a2.en-US.mac.common.tests.zip', u'firefox-51.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 21:02:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip 21:02:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip'}, attempt #1 21:02:20 INFO - Fetch https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.common.tests.zip into memory 21:02:21 INFO - Expected file size: 16434738 21:02:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip 21:02:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip'}, attempt #1 21:02:27 INFO - Fetch https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.talos.tests.zip into memory 21:02:28 INFO - Expected file size: 14414059 21:02: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')]} 21:02:29 INFO - trying https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:02:29 INFO - Downloading https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg 21:02:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg'}, attempt #1 21:02:33 INFO - Downloaded 115312472 bytes. 21:02:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:02:33 INFO - mkdir: /builds/slave/test/properties 21:02:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:02:33 INFO - Writing to file /builds/slave/test/properties/build_url 21:02:33 INFO - Contents: 21:02:33 INFO - build_url:https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg 21:02:33 INFO - Running post-action listener: _resource_record_post_action 21:02:33 INFO - Running post-action listener: set_extra_try_arguments 21:02:33 INFO - [mozharness: 2016-10-07 04:02:33.867053Z] Finished download-and-extract step (success) 21:02:33 INFO - [mozharness: 2016-10-07 04:02:33.867194Z] Running populate-webroot step. 21:02:33 INFO - Running pre-action listener: _resource_record_pre_action 21:02:33 INFO - Running main action method: populate_webroot 21:02:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:02:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:02:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:02:33 INFO - '--tppagecycles', 21:02:33 INFO - '7'], 21:02:33 INFO - 'tests': ['tsvgm']}}, 21:02:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:02:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:02:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:02:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:02:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:33 INFO - 'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:33 INFO - 'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['damp', 'tps']}, 21:02:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:33 INFO - 'tests': ['damp', 'tps']}, 21:02:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['dromaeo_dom']}, 21:02:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:02:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['basic_compositor_video']}, 21:02:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:02:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['a11yr', 21:02:33 INFO - 'ts_paint', 21:02:33 INFO - 'tpaint', 21:02:33 INFO - 'sessionrestore', 21:02:33 INFO - 'sessionrestore_no_auto_restore', 21:02:33 INFO - 'tabpaint']}, 21:02:33 INFO - 'other-e10s': {'tests': ['a11yr', 21:02:33 INFO - 'ts_paint', 21:02:33 INFO - 'tpaint', 21:02:33 INFO - 'sessionrestore', 21:02:33 INFO - 'sessionrestore_no_auto_restore', 21:02:33 INFO - 'tabpaint']}, 21:02:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:02:33 INFO - 'ts_paint', 21:02:33 INFO - 'tpaint', 21:02:33 INFO - 'sessionrestore', 21:02:33 INFO - 'sessionrestore_no_auto_restore', 21:02:33 INFO - 'tabpaint']}, 21:02:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:02:33 INFO - 'ts_paint', 21:02:33 INFO - 'tpaint', 21:02:33 INFO - 'sessionrestore', 21:02:33 INFO - 'sessionrestore_no_auto_restore', 21:02:33 INFO - 'tabpaint']}, 21:02:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['a11yr', 21:02:33 INFO - 'ts_paint', 21:02:33 INFO - 'tpaint', 21:02:33 INFO - 'sessionrestore', 21:02:33 INFO - 'sessionrestore_no_auto_restore', 21:02:33 INFO - 'tabpaint']}, 21:02:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['a11yr', 21:02:33 INFO - 'ts_paint', 21:02:33 INFO - 'tpaint', 21:02:33 INFO - 'sessionrestore', 21:02:33 INFO - 'sessionrestore_no_auto_restore', 21:02:33 INFO - 'tabpaint']}, 21:02:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['tsvgx', 21:02:33 INFO - 'tsvgr_opacity', 21:02:33 INFO - 'tart', 21:02:33 INFO - 'tscrollx', 21:02:33 INFO - 'cart']}, 21:02:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:02:33 INFO - 'tsvgr_opacity', 21:02:33 INFO - 'tart', 21:02:33 INFO - 'tscrollx', 21:02:33 INFO - 'cart']}, 21:02:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:33 INFO - 'talos_options': ['--disable-e10s'], 21:02:33 INFO - 'tests': ['tp5o']}, 21:02:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:33 INFO - 'tests': ['tp5o']}, 21:02:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:33 INFO - 'talos_options': ['--disable-e10s', 21:02:33 INFO - '--xperf_path', 21:02:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:33 INFO - 'tests': ['tp5n']}, 21:02:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:33 INFO - 'talos_options': ['--xperf_path', 21:02:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:33 INFO - 'tests': ['tp5n']}}, 21:02:33 INFO - 'talos.zip': {'path': '', 21:02:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:02:33 INFO - Running post-action listener: _resource_record_post_action 21:02:33 INFO - [mozharness: 2016-10-07 04:02:33.885521Z] Finished populate-webroot step (success) 21:02:33 INFO - [mozharness: 2016-10-07 04:02:33.885629Z] Running create-virtualenv step. 21:02:33 INFO - Running pre-action listener: _resource_record_pre_action 21:02:33 INFO - Running main action method: create_virtualenv 21:02:33 INFO - Creating virtualenv /builds/slave/test/build/venv 21:02:33 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 21:02:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:02:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:02:34 INFO - Using real prefix '/tools/python27' 21:02:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:02:34 INFO - Installing distribute.............................................................................................................................................................................................done. 21:02:37 INFO - Installing pip.................done. 21:02:37 INFO - Return code: 0 21:02:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:02:37 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')]} 21:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 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')]} 21:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:02:37 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 21:02:37 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 21:02:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:02:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:37 INFO - 'HOME': '/Users/cltbld', 21:02:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:37 INFO - 'LOGNAME': 'cltbld', 21:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:37 INFO - 'MOZ_NO_REMOTE': '1', 21:02:37 INFO - 'NO_EM_RESTART': '1', 21:02:37 INFO - 'PAGER': '/bin/cat', 21:02:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:37 INFO - 'PWD': '/builds/slave/test', 21:02:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:37 INFO - 'SHELL': '/bin/bash', 21:02:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:02:37 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:02:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:37 INFO - 'USER': 'cltbld', 21:02:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:37 INFO - 'XPC_FLAGS': '0x0', 21:02:37 INFO - 'XPC_SERVICE_NAME': '0', 21:02:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:37 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 21:02:37 INFO - Cleaning up... 21:02:37 INFO - Return code: 0 21:02:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:02:37 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')]} 21:02:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 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')]} 21:02:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:37 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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:02:37 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 21:02:37 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 21:02:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:02:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:37 INFO - 'HOME': '/Users/cltbld', 21:02:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:37 INFO - 'LOGNAME': 'cltbld', 21:02:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:37 INFO - 'MOZ_NO_REMOTE': '1', 21:02:37 INFO - 'NO_EM_RESTART': '1', 21:02:37 INFO - 'PAGER': '/bin/cat', 21:02:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:37 INFO - 'PWD': '/builds/slave/test', 21:02:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:37 INFO - 'SHELL': '/bin/bash', 21:02:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:02:37 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:02:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:37 INFO - 'USER': 'cltbld', 21:02:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:37 INFO - 'XPC_FLAGS': '0x0', 21:02:37 INFO - 'XPC_SERVICE_NAME': '0', 21:02:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:38 INFO - Downloading/unpacking psutil>=3.1.1 21:02:38 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 21:02:38 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 21:02:38 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 21:02:38 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 21:02:38 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 21:02:38 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 21:02:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:02:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:42 INFO - Installing collected packages: psutil 21:02:42 INFO - Running setup.py install for psutil 21:02:42 INFO - building 'psutil._psutil_osx' extension 21:02:42 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 21:02:42 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 21:02:42 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 21:02:42 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 21:02:42 INFO - building 'psutil._psutil_posix' extension 21:02:42 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 21:02:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:02:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:02:42 INFO - ^ 21:02:43 INFO - 1 warning generated. 21:02:43 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 21:02:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:43 INFO - Successfully installed psutil 21:02:43 INFO - Cleaning up... 21:02:43 INFO - Return code: 0 21:02:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:02:43 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')]} 21:02:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:43 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')]} 21:02:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:43 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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:02:43 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 21:02:43 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 21:02:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:02:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:43 INFO - 'HOME': '/Users/cltbld', 21:02:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:43 INFO - 'LOGNAME': 'cltbld', 21:02:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:43 INFO - 'MOZ_NO_REMOTE': '1', 21:02:43 INFO - 'NO_EM_RESTART': '1', 21:02:43 INFO - 'PAGER': '/bin/cat', 21:02:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:43 INFO - 'PWD': '/builds/slave/test', 21:02:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:43 INFO - 'SHELL': '/bin/bash', 21:02:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:02:43 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:02:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:43 INFO - 'USER': 'cltbld', 21:02:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:43 INFO - 'XPC_FLAGS': '0x0', 21:02:43 INFO - 'XPC_SERVICE_NAME': '0', 21:02:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:02:43 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 21:02:43 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 21:02:43 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 21:02:43 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 21:02:43 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 21:02:43 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 21:02:45 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:02:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:02:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:02:46 INFO - Installing collected packages: mozsystemmonitor 21:02:46 INFO - Running setup.py install for mozsystemmonitor 21:02:46 INFO - Successfully installed mozsystemmonitor 21:02:46 INFO - Cleaning up... 21:02:46 INFO - Return code: 0 21:02:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:02:46 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')]} 21:02:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:46 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')]} 21:02:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:46 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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:02:46 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 21:02:46 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 21:02:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:02:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:46 INFO - 'HOME': '/Users/cltbld', 21:02:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:46 INFO - 'LOGNAME': 'cltbld', 21:02:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:46 INFO - 'MOZ_NO_REMOTE': '1', 21:02:46 INFO - 'NO_EM_RESTART': '1', 21:02:46 INFO - 'PAGER': '/bin/cat', 21:02:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:46 INFO - 'PWD': '/builds/slave/test', 21:02:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:46 INFO - 'SHELL': '/bin/bash', 21:02:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:02:46 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:02:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:46 INFO - 'USER': 'cltbld', 21:02:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:46 INFO - 'XPC_FLAGS': '0x0', 21:02:46 INFO - 'XPC_SERVICE_NAME': '0', 21:02:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:46 INFO - Downloading/unpacking jsonschema==2.5.1 21:02:46 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 21:02:46 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 21:02:46 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 21:02:46 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 21:02:46 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 21:02:46 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 21:02:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:02:48 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:02:48 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 21:02:48 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 21:02:48 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 21:02:48 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 21:02:48 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 21:02:48 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 21:02:49 INFO - Downloading functools32-3.2.3-2.tar.gz 21:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:02:49 INFO - warning: no files found matching '*.txt' 21:02:49 INFO - no previously-included directories found matching 'build' 21:02:49 INFO - no previously-included directories found matching 'dist' 21:02:49 INFO - no previously-included directories found matching '.git*' 21:02:49 INFO - Installing collected packages: jsonschema, functools32 21:02:49 INFO - Running setup.py install for functools32 21:02:49 INFO - warning: no files found matching '*.txt' 21:02:49 INFO - no previously-included directories found matching 'build' 21:02:49 INFO - no previously-included directories found matching 'dist' 21:02:49 INFO - no previously-included directories found matching '.git*' 21:02:49 INFO - Successfully installed jsonschema functools32 21:02:49 INFO - Cleaning up... 21:02:49 INFO - Return code: 0 21:02:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:02:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:02:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:49 INFO - 'HOME': '/Users/cltbld', 21:02:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:49 INFO - 'LOGNAME': 'cltbld', 21:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:49 INFO - 'MOZ_NO_REMOTE': '1', 21:02:49 INFO - 'NO_EM_RESTART': '1', 21:02:49 INFO - 'PAGER': '/bin/cat', 21:02:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:49 INFO - 'PWD': '/builds/slave/test', 21:02:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:49 INFO - 'SHELL': '/bin/bash', 21:02:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:02:49 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:02:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:49 INFO - 'USER': 'cltbld', 21:02:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:49 INFO - 'XPC_FLAGS': '0x0', 21:02:49 INFO - 'XPC_SERVICE_NAME': '0', 21:02:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:49 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:02:49 INFO - Cleaning up... 21:02:49 INFO - Return code: 0 21:02:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:02:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:02:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:02:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:02:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:49 INFO - 'HOME': '/Users/cltbld', 21:02:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:49 INFO - 'LOGNAME': 'cltbld', 21:02:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:49 INFO - 'MOZ_NO_REMOTE': '1', 21:02:49 INFO - 'NO_EM_RESTART': '1', 21:02:49 INFO - 'PAGER': '/bin/cat', 21:02:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:49 INFO - 'PWD': '/builds/slave/test', 21:02:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:49 INFO - 'SHELL': '/bin/bash', 21:02:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:02:49 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:02:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:49 INFO - 'USER': 'cltbld', 21:02:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:49 INFO - 'XPC_FLAGS': '0x0', 21:02:49 INFO - 'XPC_SERVICE_NAME': '0', 21:02:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:50 INFO - Downloading/unpacking blobuploader==1.2.4 21:02:50 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 21:02:50 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 21:02:50 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 21:02:50 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 21:02:50 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 21:02:50 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 21:02:52 INFO - Downloading blobuploader-1.2.4.tar.gz 21:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:02:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:02:52 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 21:02:52 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 21:02:52 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 21:02:52 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 21:02:52 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 21:02:52 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 21:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:02:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:02:53 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 21:02:53 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 21:02:53 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 21:02:53 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 21:02:53 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 21:02:53 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 21:02:53 INFO - Downloading docopt-0.6.1.tar.gz 21:02:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:02:54 INFO - Installing collected packages: blobuploader, requests, docopt 21:02:54 INFO - Running setup.py install for blobuploader 21:02:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:02:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:02:54 INFO - Running setup.py install for requests 21:02:54 INFO - Running setup.py install for docopt 21:02:54 INFO - Successfully installed blobuploader requests docopt 21:02:54 INFO - Cleaning up... 21:02:54 INFO - Return code: 0 21:02:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02:54 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')]} 21:02:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:54 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')]} 21:02:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:54 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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:02:54 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 21:02:54 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 21:02:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:02:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:54 INFO - 'HOME': '/Users/cltbld', 21:02:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:54 INFO - 'LOGNAME': 'cltbld', 21:02:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:54 INFO - 'MOZ_NO_REMOTE': '1', 21:02:54 INFO - 'NO_EM_RESTART': '1', 21:02:54 INFO - 'PAGER': '/bin/cat', 21:02:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:54 INFO - 'PWD': '/builds/slave/test', 21:02:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:54 INFO - 'SHELL': '/bin/bash', 21:02:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:02:54 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:02:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:54 INFO - 'USER': 'cltbld', 21:02:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:54 INFO - 'XPC_FLAGS': '0x0', 21:02:54 INFO - 'XPC_SERVICE_NAME': '0', 21:02:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:55 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Av4f9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:55 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-0tYM1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:55 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-cQRR7F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:02:55 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-9nGhIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:02:55 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-N8ABKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:02:55 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-rMyvFL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:02:55 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-qYnYcM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:02:55 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-jSUNoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:02:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:02:55 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-dlfUBc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:02:56 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-KvGXe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:02:56 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-lM6UOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:02:56 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-CGc1p7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:02:56 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-M74X2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:02:56 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-yk9lO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:56 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-jRgN74-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:02:56 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-TFGjnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:02:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:02:56 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-A48ICn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:02:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:02:56 INFO - Running setup.py install for manifestparser 21:02:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:02:57 INFO - Running setup.py install for mozcrash 21:02:57 INFO - Running setup.py install for mozdebug 21:02:57 INFO - Running setup.py install for mozdevice 21:02:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:02:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:02:57 INFO - Running setup.py install for mozfile 21:02:57 INFO - Running setup.py install for mozhttpd 21:02:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:02:57 INFO - Running setup.py install for mozinfo 21:02:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:02:57 INFO - Running setup.py install for mozInstall 21:02:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Running setup.py install for mozleak 21:02:58 INFO - Running setup.py install for mozlog 21:02:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Running setup.py install for moznetwork 21:02:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Running setup.py install for mozprocess 21:02:58 INFO - Running setup.py install for mozprofile 21:02:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Running setup.py install for mozrunner 21:02:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:02:58 INFO - Running setup.py install for mozscreenshot 21:02:59 INFO - Running setup.py install for moztest 21:02:59 INFO - Running setup.py install for mozversion 21:02:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:02:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:02:59 INFO - Cleaning up... 21:02:59 INFO - Return code: 0 21:02:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:59 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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:02:59 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 21:02:59 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 21:02:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:02:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:59 INFO - 'HOME': '/Users/cltbld', 21:02:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:59 INFO - 'LOGNAME': 'cltbld', 21:02:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:59 INFO - 'MOZ_NO_REMOTE': '1', 21:02:59 INFO - 'NO_EM_RESTART': '1', 21:02:59 INFO - 'PAGER': '/bin/cat', 21:02:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:59 INFO - 'PWD': '/builds/slave/test', 21:02:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:59 INFO - 'SHELL': '/bin/bash', 21:02:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:02:59 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:02:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:59 INFO - 'USER': 'cltbld', 21:02:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:59 INFO - 'XPC_FLAGS': '0x0', 21:02:59 INFO - 'XPC_SERVICE_NAME': '0', 21:02:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:59 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-hX6HO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02:59 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)) 21:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:59 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-UXTmW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 21:02:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:59 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-j6xYlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:03:00 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)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-pifufh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-tnnUr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:03:00 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)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-0yIhgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:03:00 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)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-PudNcp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:03:00 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)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-cqcXzf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:03:00 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)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-tRnG9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:03:00 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)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-IcKJlX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:03:00 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)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-rJyLG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:03:00 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)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-5BnD6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:03:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:03:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:03:00 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-fiFYUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:03:01 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)) 21:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:03:01 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-6_TLWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 21:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:01 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-yfQ4JM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:01 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)) 21:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:03:01 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-ylSJvK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:03:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:03:01 INFO - Running setup.py (path:/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/pip-Nfzbjx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:03:01 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)) 21:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:03:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:03:01 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)) 21:03:01 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:03:01 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:03:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:03 INFO - Downloading blessings-1.6.tar.gz 21:03:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:03:04 INFO - Installing collected packages: blessings 21:03:04 INFO - Running setup.py install for blessings 21:03:04 INFO - Successfully installed blessings 21:03:04 INFO - Cleaning up... 21:03:04 INFO - Return code: 0 21:03:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:03:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:03:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:03:04 INFO - Reading from file tmpfile_stdout 21:03:04 INFO - Current package versions: 21:03:04 INFO - blessings == 1.6 21:03:04 INFO - blobuploader == 1.2.4 21:03:04 INFO - docopt == 0.6.1 21:03:04 INFO - functools32 == 3.2.3-2 21:03:04 INFO - jsonschema == 2.5.1 21:03:04 INFO - manifestparser == 1.1 21:03:04 INFO - mozInstall == 1.12 21:03:04 INFO - mozcrash == 0.17 21:03:04 INFO - mozdebug == 0.1 21:03:04 INFO - mozdevice == 0.48 21:03:04 INFO - mozfile == 1.2 21:03:04 INFO - mozhttpd == 0.7 21:03:04 INFO - mozinfo == 0.9 21:03:04 INFO - mozleak == 0.1 21:03:04 INFO - mozlog == 3.4 21:03:04 INFO - moznetwork == 0.27 21:03:04 INFO - mozprocess == 0.23 21:03:04 INFO - mozprofile == 0.28 21:03:04 INFO - mozrunner == 6.12 21:03:04 INFO - mozscreenshot == 0.1 21:03:04 INFO - mozsystemmonitor == 0.3 21:03:04 INFO - moztest == 0.7 21:03:04 INFO - mozversion == 1.4 21:03:04 INFO - psutil == 3.1.1 21:03:04 INFO - requests == 1.2.3 21:03:04 INFO - wsgiref == 0.1.2 21:03:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03:04 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')]} 21:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:04 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')]} 21:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:04 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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:03:04 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 21:03:04 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 21:03:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:03:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:03:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:03:04 INFO - 'HOME': '/Users/cltbld', 21:03:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:03:04 INFO - 'LOGNAME': 'cltbld', 21:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:04 INFO - 'MOZ_NO_REMOTE': '1', 21:03:04 INFO - 'NO_EM_RESTART': '1', 21:03:04 INFO - 'PAGER': '/bin/cat', 21:03:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:04 INFO - 'PWD': '/builds/slave/test', 21:03:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:03:04 INFO - 'SHELL': '/bin/bash', 21:03:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:03:04 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:03:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:03:04 INFO - 'USER': 'cltbld', 21:03:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:03:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:04 INFO - 'XPC_FLAGS': '0x0', 21:03:04 INFO - 'XPC_SERVICE_NAME': '0', 21:03:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:03:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:04 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)) 21:03:04 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)) 21:03:04 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)) 21:03:04 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)) 21:03:04 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)) 21:03:04 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)) 21:03:04 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)) 21:03:04 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)) 21:03:04 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)) 21:03:04 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)) 21:03:04 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)) 21:03:04 INFO - Cleaning up... 21:03:04 INFO - Return code: 0 21:03:04 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:03:04 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')]} 21:03:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:04 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')]} 21:03:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:04 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 0x10cd69490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ccdf570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82fbd63100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, '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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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 21:03:04 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 21:03:04 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 21:03:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:03:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:03:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:03:04 INFO - 'HOME': '/Users/cltbld', 21:03:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:03:04 INFO - 'LOGNAME': 'cltbld', 21:03:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:04 INFO - 'MOZ_NO_REMOTE': '1', 21:03:04 INFO - 'NO_EM_RESTART': '1', 21:03:04 INFO - 'PAGER': '/bin/cat', 21:03:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:03:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:04 INFO - 'PWD': '/builds/slave/test', 21:03:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:03:04 INFO - 'SHELL': '/bin/bash', 21:03:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:03:04 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:03:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:03:04 INFO - 'USER': 'cltbld', 21:03:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:03:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:03:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:04 INFO - 'XPC_FLAGS': '0x0', 21:03:04 INFO - 'XPC_SERVICE_NAME': '0', 21:03:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:03:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:03:05 INFO - Cleaning up... 21:03:05 INFO - Return code: 0 21:03:05 INFO - Running post-action listener: _resource_record_post_action 21:03:05 INFO - Running post-action listener: _start_resource_monitoring 21:03:05 INFO - Starting resource monitoring. 21:03:05 INFO - [mozharness: 2016-10-07 04:03:05.204323Z] Finished create-virtualenv step (success) 21:03:05 INFO - [mozharness: 2016-10-07 04:03:05.205276Z] Running install step. 21:03:05 INFO - Running pre-action listener: _resource_record_pre_action 21:03:05 INFO - Running main action method: install 21:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:03:05 INFO - Reading from file tmpfile_stdout 21:03:05 INFO - Detecting whether we're running mozinstall >=1.0... 21:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:03:05 INFO - Reading from file tmpfile_stdout 21:03:05 INFO - Output received: 21:03:05 INFO - Usage: mozinstall [options] installer 21:03:05 INFO - Options: 21:03:05 INFO - -h, --help show this help message and exit 21:03:05 INFO - -d DEST, --destination=DEST 21:03:05 INFO - Directory to install application into. [default: 21:03:05 INFO - "/builds/slave/test"] 21:03:05 INFO - --app=APP Application being installed. [default: firefox] 21:03:05 INFO - mkdir: /builds/slave/test/build/application 21:03:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 21:03:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 21:03:38 INFO - Reading from file tmpfile_stdout 21:03:38 INFO - Output received: 21:03:38 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 21:03:38 INFO - Running post-action listener: _resource_record_post_action 21:03:38 INFO - [mozharness: 2016-10-07 04:03:38.805701Z] Finished install step (success) 21:03:38 INFO - [mozharness: 2016-10-07 04:03:38.805874Z] Running run-tests step. 21:03:38 INFO - Running pre-action listener: _resource_record_pre_action 21:03:38 INFO - Running main action method: run_tests 21:03:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:03:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:03:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:03:38 INFO - 2016-10-06 21:03:38.820 screenresolution[1655:9167] starting screenresolution argv=screenresolution get 21:03:38 INFO - 2016-10-06 21:03:38.822 screenresolution[1655:9167] Display 0: 1600x1200x32@60 21:03:38 INFO - 2016-10-06 21:03:38.828 screenresolution[1656:9169] starting screenresolution argv=screenresolution list 21:03:38 INFO - Available Modes on Display 0 21:03:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:03:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:03:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:03:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:03:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:03:39 INFO - Intel Iris: 21:03:39 INFO - Chipset Model: Intel Iris 21:03:39 INFO - Type: GPU 21:03:39 INFO - Bus: Built-In 21:03:39 INFO - VRAM (Dynamic, Max): 1536 MB 21:03:39 INFO - Vendor: Intel (0x8086) 21:03:39 INFO - Device ID: 0x0a2e 21:03:39 INFO - Revision ID: 0x0009 21:03:39 INFO - Displays: 21:03:39 INFO - Display: 21:03:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:03:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:03:39 INFO - Display Serial Number: 1600x1200 60 21:03:39 INFO - Main Display: Yes 21:03:39 INFO - Mirror: Off 21:03:39 INFO - Online: Yes 21:03:39 INFO - Rotation: Supported 21:03:39 INFO - Return code: 0 21:03:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:03:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:03:39 INFO - Python 2.7.3 21:03:39 INFO - Return code: 0 21:03:39 INFO - grabbing minidump binary from tooltool 21:03:39 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')]} 21:03:39 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 0x10cb7dd30>, '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 0x10c9e3db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10cb75b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:03:39 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 21:03:39 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 21:03:39 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 21:03:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:03:39 INFO - Return code: 0 21:03:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:03:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:03:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:03:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:03:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:03:39 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/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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 21:03:39 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/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0309 --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 21:03:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZRYgs5H3W3/Render', 21:03:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:03:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:03:39 INFO - 'HOME': '/Users/cltbld', 21:03:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:03:39 INFO - 'LOGNAME': 'cltbld', 21:03:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:03:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:03:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:39 INFO - 'MOZ_NO_REMOTE': '1', 21:03:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:03:39 INFO - 'NO_EM_RESTART': '1', 21:03:39 INFO - 'PAGER': '/bin/cat', 21:03:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:03:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:39 INFO - 'PWD': '/builds/slave/test', 21:03:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:03:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:03:39 INFO - 'SHELL': '/bin/bash', 21:03:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hFJBcUgWno/Listeners', 21:03:39 INFO - 'TMPDIR': '/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/', 21:03:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:03:39 INFO - 'USER': 'cltbld', 21:03:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:03:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:03:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:39 INFO - 'XPC_FLAGS': '0x0', 21:03:39 INFO - 'XPC_SERVICE_NAME': '0', 21:03:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:03:39 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/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0309', '--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 21:03:39 INFO - mozversion application_buildid: 20161006183603 21:03:39 INFO - mozversion application_changeset: 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 21:03:39 INFO - mozversion application_display_name: FirefoxDeveloperEdition 21:03:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:03:39 INFO - mozversion application_name: Firefox 21:03:39 INFO - mozversion application_remotingname: firefox-dev 21:03:39 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:03:39 INFO - mozversion application_vendor: Mozilla 21:03:39 INFO - mozversion application_version: 51.0a2 21:03:39 INFO - mozversion platform_buildid: 20161006183603 21:03:39 INFO - mozversion platform_changeset: 6eefe948a16906fb0f4f9134ea75b52e0638c4f9 21:03:39 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 21:03:39 INFO - mozversion platform_version: 51.0a2 21:03:39 INFO - using testdate: 1475813019 21:03:39 INFO - actual date: 1475813019 21:03:39 INFO - starting webserver on 'localhost:49272' 21:03:39 INFO - SUITE-START | Running 2 tests 21:03:39 INFO - TEST-START | dromaeo_css 21:03:39 INFO - operating with platform_type : mac_ 21:03:39 INFO - Initialising browser for dromaeo_css test... 21:03:39 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpfGUmMM/profile http://localhost:49272/getInfo.html) 21:03:41 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 21:03:41 INFO - PROCESS | 1666 | colorDepth:24 21:03:41 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 21:03:41 INFO - PROCESS | 1666 | __metrics 21:03:41 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:03:41 INFO - PROCESS | 1666 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:03:42 INFO - TEST-INFO | 1666: exit 0 21:03:42 INFO - Browser initialized. 21:03:42 INFO - Running cycle 1/1 for dromaeo_css test... 21:03:42 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpfGUmMM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:03:54 INFO - PROCESS | 1669 | RSS: Main: 219283456 21:03:54 INFO - PROCESS | 1669 | 21:04:45 INFO - PROCESS | 1669 | 1475813085584 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:06:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 21:06:59 INFO - PROCESS | 1669 | RSS: Main: 354177024 21:06:59 INFO - PROCESS | 1669 | 21:10:02 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 21:10:02 INFO - PROCESS | 1669 | RSS: Main: 350330880 21:10:02 INFO - PROCESS | 1669 | 21:13:04 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 21:13:05 INFO - PROCESS | 1669 | RSS: Main: 332132352 21:13:05 INFO - PROCESS | 1669 | 21:16:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 21:16:08 INFO - PROCESS | 1669 | RSS: Main: 323297280 21:16:08 INFO - PROCESS | 1669 | 21:19:12 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 21:19:12 INFO - PROCESS | 1669 | RSS: Main: 310263808 21:19:12 INFO - PROCESS | 1669 | 21:22:15 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 21:22:15 INFO - PROCESS | 1669 | RSS: Main: 366370816 21:22:15 INFO - PROCESS | 1669 | 21:22:15 INFO - PROCESS | 1669 | __start_tp_report 21:22:15 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 21:22:15 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 21:22:15 INFO - PROCESS | 1669 | |i|pagename|runs| 21:22:15 INFO - PROCESS | 1669 | |0;dojo.html;2774.625425567549;3322.053214833772;3341.3818443587925;3354.84257931014;3389.1018879996805;5622.8313150605445;5672.404397538261;5683.516901063409;5686.431356864311;5719.542436605072;5608;5699.800506982257;5707.14392841073;5707.258056452655;5741.569382296334;5129.717865517395;5150.150225212836;5173.844784656466;5186.118359878811;5202.557782588485;5110.744462776846;5124.231365295198;5129.0767661820855;5252.8161514347;5302.3637163540425;4916.704997700132;5116.951025039876;5169.431362550116;5183.948160518403;5192.376914770233;5172.431032586413;5207.453217412193;5243.711595862226;5249.86875328116;5304.6286759926825;5057.8229761958155;5108.080545501808;5171.3535808024;5190.480951904817;5190.71451070191;4541.296099104644;5584.329880414376;5658.377578466366;5673.978683836907;5688.232088668018;6083.878322433527;6098.420650038283;6129.846753831145;6141.78503752371;6155.199824022893;6209.441150296449;6279.623222606659;6282.465990390822;6284.528660350446;6290.62256264621;5589.916151257735;5643.971780141073;5733.541316694655;5775.335836378828;5784;6282.371762823681;6286.182796236551;6293.370662933761;6301.117843501822;6309.873802523924;6149.84625384369;6152.907706384408;6157.076438534255;6163.229596300463;6181.84545386369;6046.3349031606485;6117.357677443893;6138.478229350555;6143.692815359214;6266.467350275187;6119.571629985859;6122.265328160649;6130.773845230971;6132.417420345149;6134.754609815646;6096.390360963868;6116.8227554565365;6123.374132580163;6136.938630613726;6144.2319710036245;4811.855644330676;4872.8781780455065;4875.731834749052;4896.36347274852;4920;4381.079973205598;4394.384786129945;4410.80151393188;4431.711938723973;4440.62254708347;5524.530414914697;5623.268975033219;5720.2849643794525;5729.656220626775;5733.684647344436;5093.18509038552;6154.353792851686;6190.721417536221;6223.688815559204;6267.874642507124;5714.3999880012;5722.828315150552;5728.656280623176;5736.368999410061;5772;5334.946650533522;5338.706371149624;5348.1175606025345;5360.678359298377;5363.168708850135;6207.16203312547;6217.751289948442;6224.751009959551;6250.687465626791;6267.373262673878;6265.780697675559;6270.435660790368;6276.529260305587;6292.024736165901;6293.181886354744;6271.059341098871;6288.402601752826;6289.779857704958;6295.496360291258;6299.685015749103;5814.796482123105;5914.172015917689;6033.366496517802;6062.484688801501;6098.298695650057;5253.921191182212;5519.668819870821;5964.791232307022;6141.332587233645;6223.066540019034;5882.941070607332;6020.1270815730595;6029.547783916311;6032.245969253843;6035.094735789491;4502.774861256989;5716.971415142898;5982.551308651781;5992.700364981821;6045.788397406246;5837.824865254049;5861.003629383101;5863.413658634103;5873.4126587340925;5894.174815525744;5951.404859514014;6019.337872833898;6032.215811944419;6039.486643635164;6040.6979651018155;5692.686902220252;5716.456936591017;5831.679257640871;5831.7375718093635;5841.153032810304 21:22:15 INFO - PROCESS | 1669 | |1;ext.html;473.2215505493463;475.2989340722437;475.3962467666064;521.8434469659102;542.701514167208;26340.3414914627;41496;42752.78623606878;42779;44532.77733611327;44057.11885762283;44303.335449968275;44357.556424435745;44529.777351113284;44595;8864.955675221614;9933.950330248339;10105.242106842017;10112.443815590139;10121.746956326077;8751.037385887546;10244.385336879774;12100.515979360815;12303.938480307586;12521.624351269476;12199.451024703865;12244.142909996304;12248.571300004502;12264.81602775959;12266.81599776004;12258.509659613605;12338.938305308417;12352.938235308855;12372.752544949051;12378.257304561665;12193.329366884818;12264.877351226463;12277.938610306892;12288.385580720927;12322.75354492914;41379.58620413818;41736.37395439071;41827.1634567307;41837.79081104575;41891.1621767563;3318.2699806042633;3836.693064554857;4011.117554138085;4026.4966879140106;4038.172174704179;30761.077167685005;31353.37293254122;32099;32134.839325803456;32987;3248.5289633003317;3261.869525218988;3301.983490082558;3322.684344987222;3389.034125274285;492816.0718392806;494425;497390;498112;502545;33977;34289.65710342915;34631.30737385238;62215.37784622096;62738.686306568175;35526.64473355285;35665.64334356675;35669;35692.28615427677;35753.10617234538;13874.751272385534;13974.441022358991;14016.649583760487;14040.578782636538;14052.508162214273;10238.18094552434;10421.68734937953;11508.424578771195;11582.652520424232;11593.710157246136;5678.346990096109;6465.612063276219;7772.300492955661;7809.960950195213;7891.921080789233;2881.351695868455;3216.4371235033777;3222.854971526287;3229.289556297611;3260.3805276997296;826.9917300827035;902.472053848506;961.1301771896445;976.7558110472382;1011.726833754882;29148.708512915022;29887.551686724717;30149.547756783664;30870.38259234803;31662.208444789063;844.5903736687701;1038.4911393417171;1076.284270959803;1102.211918478276;1114.9331040137617;14052.789208161887;15562.265056386612;15781.21093945321;15856.44502442409;16036.278367473491;645948;647759;650074;652560;653888.8444462264;58066;58644.70677646584;58662.12006819901;58719;58798;1208.2871106047298;1241.075398827879;1306.3076569418224;1334.3528388731459;1369.5069774880835;30776.69223307738;30900;31921.840390797897;32021.35957280795;32499.512507312884;49264.26103608377;49595.25607115824;49812.501874980786;49849.50150498449;49855.252171216736;515180;516616;518269;518397;519837;26986.05548805861;27277.727222728314;27483.450330993666;27612.861935690195;27878.58182127229;47229.52770472251;47866;48018;48629.5137048625;48746;33371.83314083414;39242.2151556973;40217.79891100526;41121;41723.956901076504;33533.16167095842;39461.80269098751;39484.802575986934;39819;39828.00429989273;37951.81024094862;38992.80503597464;39000.6099938997;39063;39222.411663824496;34115.82942085274;35071;35129.64870351264;35575.288494229455;35791.46312805258;25842;25854.482910342063;25979.350516237246;26272.868635656698;26439 21:22:15 INFO - PROCESS | 1669 | |2;jquery.html;355.28055687233365;372.47481051717074;373.71410870683917;383.7102987244631;399.504614278295;15302.158381289039;15680.686386272268;17357.30570777169;20807.895960520174;21218;20528.794712052873;20814.791852081475;21131.57736845262;21382.465438364008;21584.784152158474;5898.616589921641;5937.821865344025;6091.0863370494335;6225;6233.376662333753;4229.323308270677;6077.878442431149;6190.195274614316;6197.659128747917;6205.7517699291975;4440.42274504314;6503.349665033506;6800.761973330935;6829.795106146824;6925.238223795403;5734.197212390269;6063.757449702007;6115.266168059861;6887.932370482558;6932.584044957293;5939.792107276225;5941.881162376728;5942.851428714317;5943.227380440559;5945.583809133363;12626.368681565977;12728.98168146546;12903.87096129036;13078.86921130786;13430.328483575782;2174.717286752712;2267.263139479659;2510.272021113875;2799.7340252675963;2826.010896186339;9999.700008999742;10136.087752102272;10331;10990.890091099067;16192.676146477123;1867.7385166076624;1909.5417099896065;1912.6270377276437;1936.8256856882808;1944.0182707732504;91427;112106;112364;121730.39134804357;122093.38953305266;9260.610908363664;11186.049185819296;11312.26695190585;11512.424378781028;11714.1800073994;14471.986960912634;14496.492622758153;14512.564623061326;14520.201388923499;14545;7873.448858579959;8196.221358970888;8212.753617391369;8280.668773249123;8289.709860154866;7874;7876.448648594544;7897.565633890191;8041.477303975223;8054.798630034296;4510.188166130128;4514.864554063383;4530.29780384041;4534.115847409724;4589.449266088091;1779.9377021804175;1795.778870368136;1887.8867267963967;1957.377114666354;1969.3107412405543;828.5443006346485;873.6636394987848;875.2035647560816;900.7297810656777;954.6372378496266;20148.597028059357;21614.459638508848;21641.891790540947;21680.783192168194;21687.89156054241;908.205972022504;914.6112902016749;917.1928702741678;931.6087243357806;992.1269283030887;10361.948190259;11378.54485820558;11463.082953363712;11469.942650286863;11487.597934072268;580078;590314;592501;592635;592946;125989;129299.35350323377;130502;131174;136669.31665341608;935.251798561162;941.9905800941902;967.0716112532048;967.2503809547657;968.0899954043177;18695.439136825917;18951.957642329253;19163.712544312126;19209;19248.903755481133;47225.527744722116;53611.731941341604;54933.450665492834;55154.06960756354;55324.06365777178;76697.61651191708;81311;81703.77444338221;83717.58141209255;84283.31433371421;6688.632125233159;7948.721794737156;8039.598020099089;8057.637406316612;8369.0375606806;8978.506182159783;13084.542041028519;13180.604581862559;13240;13448.93275533616;11186.440677966231;11299.604513841976;11460.255083419552;11624.360660163435;11663.300201987908;9571.1864491519;11004.284721493077;11229;11339.149563782914;11496.712582185512;9053.818923621358;11458.968692817687;11642.76714465689;11750.353730544903;12009.39953002329;6905.37851593359;8028.959855200686;8060.596970151351;8293.543855088028;8396.370272229486;8285.4200205985;10738.355698658106;11293.548258069584;11372.488238029475;11559.722902526119 21:22:15 INFO - PROCESS | 1669 | |3;mootools.html;1385.764420048593;1541.044552377526;1541.6454215530428;1720.1915099903042;1867.8132186781315;7865.488743231693;8406.957965210173;8744.169303916135;8929.642814287421;8932.910670893289;7549.320561149495;8855.468671879675;8898.332625053115;8918.063603321654;8964.058773828752;2392.521495700858;2424.696912885889;2426.38127277544;2427.9514409711796;2432.671589335435;2373.738888722239;2417.2144053182697;2425.223928342931;2428.659987601737;2433.768791964769;2135.765065842756;2356.5389458535647;2392.83250172488;2420.4070002849326;2432.428379330856;2370.111208296889;2386.224477044959;2396.9932628295983;2402.363373705978;2408.2173293679625;2351.5296940611775;2384.6065399209283;2386.296042667417;2390.3307074019303;2398.0527691561733;8635.784105397352;8825.51459669718;8852.822943541094;8934.910650893473;8947.821043579092;5368.087425137736;5525.889482210374;5536;5544.972275138639;5559.694216818073;3601.1897323102353;3652.8356223969986;3665.5234819473562;3719.851205951759;3721.4789929409903;1100.928439651428;1110.4725255503652;1116.3246236027248;1119.1438549509633;1135.2904434728296;11769.705757356049;11782;11823.645290641294;11828;11840.407979600985;4411.625011874026;4517.435320584927;4675.742834144086;4716.481187069488;4724.291356296583;9192.402493837879;9210.401323913924;9224.30817688676;9225.86161207569;9230.953845230732;5304.708241046779;5306.97346513265;5307.416184219733;5311.840644780663;5322.707251101149;4183.330667093251;4422.889427764268;4556.111558246176;4583.289590113538;4936.555709986119;3853.653171214548;3864.53625564934;3918.1380096378753;3933.567307596162;3936.075022369741;1161.6524831195773;1172.806486929664;1180.5100883133575;1182.296533562546;1197.5150064224003;700.8423104801379;893.093510087262;908.42315129893;924.5977999570208;931.1479995803899;5686.118651609007;5859.267591551056;5909.438603332676;6037.305709843336;6124.081387791867;432.7338686707652;433.9197248508973;448.854122410218;463.6615270852297;465.06289826000636;3914.5693973662874;3942.7634341939574;4104.570231440578;4197.496300443966;4212.431321771583;9272.443653380818;10891.509882055327;10981.890181098246;11004.339739615649;11004.614838480615;10939.890601093886;10951.397673127894;10957.945210274058;10974.780504389868;11033.393163376091;6775.288594697585;8195.7951051223;8207.384446166561;8440.957795211107;8451.492910425393;5940.138679891478;5958.493528050164;6004.808244990634;6063.211782468427;6084.513238940785;9800.607975680892;9962;10191.133753630727;10211.591536338761;10213.897861021593;9465.47939863314;10160.390376577428;10288.12550933179;10376.066154046172;10464.738381540523;6988.720451181895;7428.9628551856895;7565.43259255547;7639.88540171909;7746.65140068687;8287.50274983503;8302;8320.70877519284;8388.119247479171;8418.368622353226;7508.511946723445;7571.848563028599;7603.847923041619;7642.0065391500975;7648.541087534766;7387.1135463744695;7392.186859445349;7407.370373518312;7415.777526674208;7487.47587668858;6730.663466826737;6929.930700692928;6975.337342952412;7001;7003.7548685795755;5112.182050871843;5133.486651334837;5153.922691159561;5313.096773548429;5313.681179129265;5151.793928242828;5175.560077393464;5244.580433565229;5306.097963346318;5389.811356602657 21:22:15 INFO - PROCESS | 1669 | |4;prototype.html;299.8410842253606;300.59569878513406;307.92455848317167;313.3795085730254;314.59260257965934;4724.31497432872;4903.926441103386;4994.775235114419;5212.93134907344;5407.05376559102;4458.4426946631675;5080.212567052104;5135.895782406791;5175.870603234921;5370.865728356793;4058.701215611006;4068.4304197412384;4094.795260236991;4100.52843922949;4113.321301985184;3902;4046.6560342370935;4057.5942405759483;4076.6331030207275;4106.837734944106;3709.7959612221316;3943.3690609502487;3994.960050399488;4061.4110953911663;4088.325426304671;3868;3965.1871366369824;3972.741771784825;3977.5425826030087;3991.2416640838146;3412.4540073588105;3428.9828550857337;3432.318164099573;3465.376232278189;3473.2532505511435;4231.576842315774;4613.1696294666945;5107.080725469414;5145.819896303611;5160.25176349431;4500.324951257305;4505.5719706627815;4510.819567217307;4550.726956382628;4558.948473187046;4882.389701287339;5081.237814327844;5421.241026256327;5437.32033495813;5494.532964698005;2828.8444135572536;3140.685931406864;3787.261484010619;3803.76377677256;3835;5355.544778693816;5746.88506229873;5750.367459579443;5786.971065144689;5818.981678206297;3300.1089705779304;3319.7842140260805;3459.5296998775925;3845.9615403846165;3846.442265871489;3874.4769456123627;3877.903052423712;3894.520082368682;3928.3910993796007;3951;4234.898926279128;4427.432089388147;4569.657275704269;4594.439309535071;4615.423072115986;5536.972315138399;5545.61180717354;5559.916601250984;5562;5598.1322894951345;1170.7297582123322;1252.5177806544364;1264.4120483974996;1292.8707129286995;1306.9346532673328;723.9683451082187;847.1824689174853;859.5873980489275;895.4269267668698;902.8420026495337;4375.562443755599;5184.481551844785;5191.896162076813;5196.454372290855;5250.868728281824;4693.647976401715;5078.923816142761;5671;5684.715764211773;5710.942890571124;4381.868543943623;4579.824583322895;5296.92054619181;5360.354958628092;5366.221897824794;2632.3550730071256;2686.489566982267;2947.3073827650487;2981.4037192561573;3025.6400007993802;5274.077036518671;5616.719164041863;5970.044792833126;6006.759729610854;6029.155918171459;5064.873378165576;5362.463753624685;5789.88420231593;5928.318243402064;5937.2578427696535;4847.442544107403;5490.835274941758;5530.253415788898;5889.793857215062;5974.4324289192455;4047.1096358801015;5550.972245138749;5738.876615652235;5740.249223986557;5825.2135961644635;5686.360729133441;5703.686297253525;5707.68607726579;5720.885582288414;5720.970225359475;5535.0313695104005;5935.2877654681715;5956.183364073999;5957.463828255478;6043.486303664238;3429.2627085176805;3708.2768860073106;4025.67794576439;4036.555978842384;4045.4943132108488;5170.3278573785165;5201.791928322976;5370.704611246263;5773.624714393551;5787.2187254720075;5307.169026685787;5634.774609015593;5641.617803638135;5643.134452899777;5653.2085508028085;4939.456659767495;5185.870353241199;5537.584681148849;5568.248286481273;5596.664200148004;4673.9298910517045;5145.536901678867;5289.047971365191;5368.1679339702405;5442.809501667422;4748.667593268438;4979.178435558092;5207.453217412269;5372.7582258797665;5477.561795056466;5425.782968681367;5438.293021907127;5452.400235974119;5453.972730136324;5474.562035037108 21:22:15 INFO - PROCESS | 1669 | |5;yui.html;780.4848799792138;789.6643926331311;792.3186059988412;818.6397984886652;829.900411950566;12143.878561214397;14975.326110325035;15013.699726005487;15050.172240526766;15058.322375493102;13207.141535800167;13230.735385292312;13294.601161965133;13477.865221347784;13689.520866769664;813.0730966697969;839.4082172068677;840.6385254340631;841.3395484544634;842.2251528593678;671.3957438305515;691.2707094015811;814.2834305810908;840.3319361107934;845.1337379186352;888.6090120347027;889.0398369760643;890.4034297021011;890.9643614255422;892.6474042753109;881.312576190566;881.9867701984443;882.6204731965253;883.0374891368375;883.483162350026;421.8755467137202;522.5245027025388;633.0883527720068;649.1009951217551;651.7295322441181;13927.442902283896;13969.3713782879;13994.510192143329;13999.020068595202;14019.228942408163;12476.001919846482;12538.373081345897;12638.55765048219;12648.936755316165;12827.583470549733;11735;11851.644450666494;11960.760784784343;12184.268943863397;12421.1926224796;4349.760763158025;4451.933221001687;4593.425821772278;4597.195490789132;4609.723416595015;113209;114333.99999999917;114341.85658143478;114367;121120;10143.391396516232;10216.897831021595;10323.896761032443;10474.581016759244;10629.4153821539;19305.131269092926;19312.71030934537;19315.130819112892;19328.323508677127;19334.323298684478;7203.459740519482;7316.817079573053;7340.632968351668;7410.370118539877;7454.068241469817;4127.236461254677;4183.456150700389;4224.408582798411;4342.131573685212;4414.933775993362;3189.473736833443;3222.6616205298574;3272.214668479548;3273.6235332937017;3278.246003419227;633.5691729623808;637.4517914593446;645.4642646603309;656.0913135307634;658.1444122640548;533.5491509674318;549.6894254746136;598.5600583571072;632.8670979094442;634.6731433311755;7903.68385264583;8676.8698469523;8797.29621630268;8798;9072;609.7926704920349;621.5959626242887;642.9099926010363;675.9425448836904;704.8836941904631;4182.581741825793;4395.53846846083;4412;4461.464624245112;4578.5650363215445;95772;118876.40561797135;129315;150447.99104017857;155859;121725.39137304257;126089.73910260963;126233.36883315709;130527;130649.34675326562;100273.49863250637;105967.47016264715;107946.46026769816;110371.89628103616;114219.42890285495;7360.4479664026485;8129.187081291823;8194.262516373556;8426.789330266793;8734.126587341469;60330.69834650798;60433.69783151056;60464.418726723525;61664.69167654133;63150.68424657847;76859;90682.66466691664;94908;96557;97043;10886.129109671048;10953.83569246478;11254.606088786853;11347.148963827582;11587.957083862493;12009.459574319351;12012.519499219934;12329.69175770577;12449.751004980031;12467.688307792016;10871.565137394417;11501.194916355775;11918.225315354473;12070.396480175781;12336.753264934472;11393.886061139283;11855.822162667739;11980.28118312904;12070;12110.673503257009;11319.377434241196;11690.357030363411;11922.344271065174;12429.875701242872;12464;9199.954000229956;9265.53672316395;9958.502074896081;10050.949745251519;10111.89888101139;9412.67055653049;9838.852417213891;9866.950665246628;9868.161206297546;9906.554205060645 21:22:15 INFO - PROCESS | 1669 | __end_tp_report 21:22:15 INFO - PROCESS | 1669 | __start_cc_report 21:22:15 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1281 21:22:15 INFO - PROCESS | 1669 | __end_cc_report 21:22:15 INFO - PROCESS | 1669 | __startTimestamp1475814135865__endTimestamp 21:22:15 INFO - PROCESS | 1669 | 21:22:15 INFO - PROCESS | 1669 | ------- Summary: start ------- 21:22:15 INFO - PROCESS | 1669 | Number of tests: 6 21:22:15 INFO - PROCESS | 1669 | 21:22:15 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5659.79 Median:5814.80 stddev:652.62 (11.2%) stddev-sans-first:614.12 21:22:15 INFO - PROCESS | 1669 | Values: 2774.6 3322.1 3341.4 3354.8 3389.1 5622.8 5672.4 5683.5 5686.4 5719.5 5608.0 5699.8 5707.1 5707.3 5741.6 5129.7 5150.2 5173.8 5186.1 5202.6 5110.7 5124.2 5129.1 5252.8 5302.4 4916.7 5117.0 5169.4 5183.9 5192.4 5172.4 5207.5 5243.7 5249.9 5304.6 5057.8 5108.1 5171.4 5190.5 5190.7 4541.3 5584.3 5658.4 5674.0 5688.2 6083.9 6098.4 6129.8 6141.8 6155.2 6209.4 6279.6 6282.5 6284.5 6290.6 5589.9 5644.0 5733.5 5775.3 5784.0 6282.4 6286.2 6293.4 6301.1 6309.9 6149.8 6152.9 6157.1 6163.2 6181.8 6046.3 6117.4 6138.5 6143.7 6266.5 6119.6 6122.3 6130.8 6132.4 6134.8 6096.4 6116.8 6123.4 6136.9 6144.2 4811.9 4872.9 4875.7 4896.4 4920.0 4381.1 4394.4 4410.8 4431.7 4440.6 5524.5 5623.3 5720.3 5729.7 5733.7 5093.2 6154.4 6190.7 6223.7 6267.9 5714.4 5722.8 5728.7 5736.4 5772.0 5334.9 5338.7 5348.1 5360.7 5363.2 6207.2 6217.8 6224.8 6250.7 6267.4 6265.8 6270.4 6276.5 6292.0 6293.2 6271.1 6288.4 6289.8 6295.5 6299.7 5814.8 5914.2 6033.4 6062.5 6098.3 5253.9 5519.7 5964.8 6141.3 6223.1 5882.9 6020.1 6029.5 6032.2 6035.1 4502.8 5717.0 5982.6 5992.7 6045.8 5837.8 5861.0 5863.4 5873.4 5894.2 5951.4 6019.3 6032.2 6039.5 6040.7 5692.7 5716.5 5831.7 5831.7 5841.2 21:22:15 INFO - PROCESS | 1669 | 21:22:15 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:67958.75 Median:35100.32 stddev:149477.37 (425.9%) stddev-sans-first:149810.81 21:22:15 INFO - PROCESS | 1669 | Values: 473.2 475.3 475.4 521.8 542.7 26340.3 41496.0 42752.8 42779.0 44532.8 44057.1 44303.3 44357.6 44529.8 44595.0 8865.0 9934.0 10105.2 10112.4 10121.7 8751.0 10244.4 12100.5 12303.9 12521.6 12199.5 12244.1 12248.6 12264.8 12266.8 12258.5 12338.9 12352.9 12372.8 12378.3 12193.3 12264.9 12277.9 12288.4 12322.8 41379.6 41736.4 41827.2 41837.8 41891.2 3318.3 3836.7 4011.1 4026.5 4038.2 30761.1 31353.4 32099.0 32134.8 32987.0 3248.5 3261.9 3302.0 3322.7 3389.0 492816.1 494425.0 497390.0 498112.0 502545.0 33977.0 34289.7 34631.3 62215.4 62738.7 35526.6 35665.6 35669.0 35692.3 35753.1 13874.8 13974.4 14016.6 14040.6 14052.5 10238.2 10421.7 11508.4 11582.7 11593.7 5678.3 6465.6 7772.3 7810.0 7891.9 2881.4 3216.4 3222.9 3229.3 3260.4 827.0 902.5 961.1 976.8 1011.7 29148.7 29887.6 30149.5 30870.4 31662.2 844.6 1038.5 1076.3 1102.2 1114.9 14052.8 15562.3 15781.2 15856.4 16036.3 645948.0 647759.0 650074.0 652560.0 653888.8 58066.0 58644.7 58662.1 58719.0 58798.0 1208.3 1241.1 1306.3 1334.4 1369.5 30776.7 30900.0 31921.8 32021.4 32499.5 49264.3 49595.3 49812.5 49849.5 49855.3 515180.0 516616.0 518269.0 518397.0 519837.0 26986.1 27277.7 27483.5 27612.9 27878.6 47229.5 47866.0 48018.0 48629.5 48746.0 33371.8 39242.2 40217.8 41121.0 41724.0 33533.2 39461.8 39484.8 39819.0 39828.0 37951.8 38992.8 39000.6 39063.0 39222.4 34115.8 35071.0 35129.6 35575.3 35791.5 25842.0 25854.5 25979.4 26272.9 26439.0 21:22:15 INFO - PROCESS | 1669 | 21:22:15 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:34468.46 Median:378.71 stddev:98556.80 (26024.2%) stddev-sans-first:98799.99 21:22:15 INFO - PROCESS | 1669 | Values: 355.3 372.5 373.7 383.7 399.5 15302.2 15680.7 17357.3 20807.9 21218.0 20528.8 20814.8 21131.6 21382.5 21584.8 5898.6 5937.8 6091.1 6225.0 6233.4 4229.3 6077.9 6190.2 6197.7 6205.8 4440.4 6503.3 6800.8 6829.8 6925.2 5734.2 6063.8 6115.3 6887.9 6932.6 5939.8 5941.9 5942.9 5943.2 5945.6 12626.4 12729.0 12903.9 13078.9 13430.3 2174.7 2267.3 2510.3 2799.7 2826.0 9999.7 10136.1 10331.0 10990.9 16192.7 1867.7 1909.5 1912.6 1936.8 1944.0 91427.0 112106.0 112364.0 121730.4 122093.4 9260.6 11186.0 11312.3 11512.4 11714.2 14472.0 14496.5 14512.6 14520.2 14545.0 7873.4 8196.2 8212.8 8280.7 8289.7 7874.0 7876.4 7897.6 8041.5 8054.8 4510.2 4514.9 4530.3 4534.1 4589.4 1779.9 1795.8 1887.9 1957.4 1969.3 828.5 873.7 875.2 900.7 954.6 20148.6 21614.5 21641.9 21680.8 21687.9 908.2 914.6 917.2 931.6 992.1 10361.9 11378.5 11463.1 11469.9 11487.6 580078.0 590314.0 592501.0 592635.0 592946.0 125989.0 129299.4 130502.0 131174.0 136669.3 935.3 942.0 967.1 967.3 968.1 18695.4 18952.0 19163.7 19209.0 19248.9 47225.5 53611.7 54933.5 55154.1 55324.1 76697.6 81311.0 81703.8 83717.6 84283.3 6688.6 7948.7 8039.6 8057.6 8369.0 8978.5 13084.5 13180.6 13240.0 13448.9 11186.4 11299.6 11460.3 11624.4 11663.3 9571.2 11004.3 11229.0 11339.1 11496.7 9053.8 11459.0 11642.8 11750.4 12009.4 6905.4 8029.0 8060.6 8293.5 8396.4 8285.4 10738.4 11293.5 11372.5 11559.7 21:22:15 INFO - PROCESS | 1669 | 21:22:15 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5718.59 Median:5024.37 stddev:3214.33 (64.0%) stddev-sans-first:3206.85 21:22:15 INFO - PROCESS | 1669 | Values: 1385.8 1541.0 1541.6 1720.2 1867.8 7865.5 8407.0 8744.2 8929.6 8932.9 7549.3 8855.5 8898.3 8918.1 8964.1 2392.5 2424.7 2426.4 2428.0 2432.7 2373.7 2417.2 2425.2 2428.7 2433.8 2135.8 2356.5 2392.8 2420.4 2432.4 2370.1 2386.2 2397.0 2402.4 2408.2 2351.5 2384.6 2386.3 2390.3 2398.1 8635.8 8825.5 8852.8 8934.9 8947.8 5368.1 5525.9 5536.0 5545.0 5559.7 3601.2 3652.8 3665.5 3719.9 3721.5 1100.9 1110.5 1116.3 1119.1 1135.3 11769.7 11782.0 11823.6 11828.0 11840.4 4411.6 4517.4 4675.7 4716.5 4724.3 9192.4 9210.4 9224.3 9225.9 9231.0 5304.7 5307.0 5307.4 5311.8 5322.7 4183.3 4422.9 4556.1 4583.3 4936.6 3853.7 3864.5 3918.1 3933.6 3936.1 1161.7 1172.8 1180.5 1182.3 1197.5 700.8 893.1 908.4 924.6 931.1 5686.1 5859.3 5909.4 6037.3 6124.1 432.7 433.9 448.9 463.7 465.1 3914.6 3942.8 4104.6 4197.5 4212.4 9272.4 10891.5 10981.9 11004.3 11004.6 10939.9 10951.4 10957.9 10974.8 11033.4 6775.3 8195.8 8207.4 8441.0 8451.5 5940.1 5958.5 6004.8 6063.2 6084.5 9800.6 9962.0 10191.1 10211.6 10213.9 9465.5 10160.4 10288.1 10376.1 10464.7 6988.7 7429.0 7565.4 7639.9 7746.7 8287.5 8302.0 8320.7 8388.1 8418.4 7508.5 7571.8 7603.8 7642.0 7648.5 7387.1 7392.2 7407.4 7415.8 7487.5 6730.7 6929.9 6975.3 7001.0 7003.8 5112.2 5133.5 5153.9 5313.1 5313.7 5151.8 5175.6 5244.6 5306.1 5389.8 21:22:15 INFO - PROCESS | 1669 | 21:22:15 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4486.73 Median:5094.16 stddev:1390.53 (27.3%) stddev-sans-first:1358.46 21:22:15 INFO - PROCESS | 1669 | Values: 299.8 300.6 307.9 313.4 314.6 4724.3 4903.9 4994.8 5212.9 5407.1 4458.4 5080.2 5135.9 5175.9 5370.9 4058.7 4068.4 4094.8 4100.5 4113.3 3902.0 4046.7 4057.6 4076.6 4106.8 3709.8 3943.4 3995.0 4061.4 4088.3 3868.0 3965.2 3972.7 3977.5 3991.2 3412.5 3429.0 3432.3 3465.4 3473.3 4231.6 4613.2 5107.1 5145.8 5160.3 4500.3 4505.6 4510.8 4550.7 4558.9 4882.4 5081.2 5421.2 5437.3 5494.5 2828.8 3140.7 3787.3 3803.8 3835.0 5355.5 5746.9 5750.4 5787.0 5819.0 3300.1 3319.8 3459.5 3846.0 3846.4 3874.5 3877.9 3894.5 3928.4 3951.0 4234.9 4427.4 4569.7 4594.4 4615.4 5537.0 5545.6 5559.9 5562.0 5598.1 1170.7 1252.5 1264.4 1292.9 1306.9 724.0 847.2 859.6 895.4 902.8 4375.6 5184.5 5191.9 5196.5 5250.9 4693.6 5078.9 5671.0 5684.7 5710.9 4381.9 4579.8 5296.9 5360.4 5366.2 2632.4 2686.5 2947.3 2981.4 3025.6 5274.1 5616.7 5970.0 6006.8 6029.2 5064.9 5362.5 5789.9 5928.3 5937.3 4847.4 5490.8 5530.3 5889.8 5974.4 4047.1 5551.0 5738.9 5740.2 5825.2 5686.4 5703.7 5707.7 5720.9 5721.0 5535.0 5935.3 5956.2 5957.5 6043.5 3429.3 3708.3 4025.7 4036.6 4045.5 5170.3 5201.8 5370.7 5773.6 5787.2 5307.2 5634.8 5641.6 5643.1 5653.2 4939.5 5185.9 5537.6 5568.2 5596.7 4673.9 5145.5 5289.0 5368.2 5442.8 4748.7 4979.2 5207.5 5372.8 5477.6 5425.8 5438.3 5452.4 5454.0 5474.6 21:22:15 INFO - PROCESS | 1669 | 21:22:15 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:23740.98 Median:4283.27 stddev:38432.13 (897.3%) stddev-sans-first:38501.28 21:22:15 INFO - PROCESS | 1669 | Values: 780.5 789.7 792.3 818.6 829.9 12143.9 14975.3 15013.7 15050.2 15058.3 13207.1 13230.7 13294.6 13477.9 13689.5 813.1 839.4 840.6 841.3 842.2 671.4 691.3 814.3 840.3 845.1 888.6 889.0 890.4 891.0 892.6 881.3 882.0 882.6 883.0 883.5 421.9 522.5 633.1 649.1 651.7 13927.4 13969.4 13994.5 13999.0 14019.2 12476.0 12538.4 12638.6 12648.9 12827.6 11735.0 11851.6 11960.8 12184.3 12421.2 4349.8 4451.9 4593.4 4597.2 4609.7 113209.0 114334.0 114341.9 114367.0 121120.0 10143.4 10216.9 10323.9 10474.6 10629.4 19305.1 19312.7 19315.1 19328.3 19334.3 7203.5 7316.8 7340.6 7410.4 7454.1 4127.2 4183.5 4224.4 4342.1 4414.9 3189.5 3222.7 3272.2 3273.6 3278.2 633.6 637.5 645.5 656.1 658.1 533.5 549.7 598.6 632.9 634.7 7903.7 8676.9 8797.3 8798.0 9072.0 609.8 621.6 642.9 675.9 704.9 4182.6 4395.5 4412.0 4461.5 4578.6 95772.0 118876.4 129315.0 150448.0 155859.0 121725.4 126089.7 126233.4 130527.0 130649.3 100273.5 105967.5 107946.5 110371.9 114219.4 7360.4 8129.2 8194.3 8426.8 8734.1 60330.7 60433.7 60464.4 61664.7 63150.7 76859.0 90682.7 94908.0 96557.0 97043.0 10886.1 10953.8 11254.6 11347.1 11588.0 12009.5 12012.5 12329.7 12449.8 12467.7 10871.6 11501.2 11918.2 12070.4 12336.8 11393.9 11855.8 11980.3 12070.0 12110.7 11319.4 11690.4 11922.3 12429.9 12464.0 9200.0 9265.5 9958.5 10050.9 10111.9 9412.7 9838.9 9867.0 9868.2 9906.6 21:22:15 INFO - PROCESS | 1669 | -------- Summary: end -------- 21:22:15 INFO - PROCESS | 1669 | 21:22:16 INFO - TEST-INFO | 1669: exit 0 21:22:16 INFO - TEST-OK | dromaeo_css | took 1117079ms 21:22:16 INFO - TEST-START | kraken 21:22:16 INFO - operating with platform_type : mac_ 21:22:16 INFO - Initialising browser for kraken test... 21:22:16 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpP_okpn/profile http://localhost:49272/getInfo.html) 21:22:18 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 21:22:18 INFO - PROCESS | 1674 | colorDepth:24 21:22:18 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 21:22:18 INFO - PROCESS | 1674 | __metrics 21:22:18 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:22:18 INFO - PROCESS | 1674 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:22:19 INFO - TEST-INFO | 1674: exit 0 21:22:19 INFO - Browser initialized. 21:22:19 INFO - Running cycle 1/1 for kraken test... 21:22:19 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/T/tmpP_okpn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:22:31 INFO - PROCESS | 1675 | RSS: Main: 219836416 21:22:31 INFO - PROCESS | 1675 | 21:22:34 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 21:22:35 INFO - PROCESS | 1675 | RSS: Main: 270065664 21:22:35 INFO - PROCESS | 1675 | 21:22:37 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 21:22:38 INFO - PROCESS | 1675 | RSS: Main: 280993792 21:22:38 INFO - PROCESS | 1675 | 21:22:41 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 21:22:42 INFO - PROCESS | 1675 | RSS: Main: 379248640 21:22:42 INFO - PROCESS | 1675 | 21:22:44 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 21:22:44 INFO - PROCESS | 1675 | RSS: Main: 279244800 21:22:44 INFO - PROCESS | 1675 | 21:22:46 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:22:47 INFO - PROCESS | 1675 | RSS: Main: 281128960 21:22:47 INFO - PROCESS | 1675 | 21:22:50 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 21:22:50 INFO - PROCESS | 1675 | RSS: Main: 318935040 21:22:50 INFO - PROCESS | 1675 | 21:22:53 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 21:22:54 INFO - PROCESS | 1675 | RSS: Main: 319664128 21:22:54 INFO - PROCESS | 1675 | 21:22:57 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 21:22:57 INFO - PROCESS | 1675 | RSS: Main: 316223488 21:22:57 INFO - PROCESS | 1675 | 21:22:59 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:22:59 INFO - PROCESS | 1675 | RSS: Main: 289767424 21:22:59 INFO - PROCESS | 1675 | 21:23:01 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:23:02 INFO - PROCESS | 1675 | RSS: Main: 296251392 21:23:02 INFO - PROCESS | 1675 | 21:23:04 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:23:05 INFO - PROCESS | 1675 | RSS: Main: 302190592 21:23:05 INFO - PROCESS | 1675 | 21:23:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:23:09 INFO - PROCESS | 1675 | RSS: Main: 311197696 21:23:09 INFO - PROCESS | 1675 | 21:23:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:23:12 INFO - PROCESS | 1675 | RSS: Main: 311005184 21:23:12 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 21:23:14 INFO - PROCESS | 1675 | RSS: Main: 354902016 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | __start_tp_report 21:23:14 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 21:23:14 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 21:23:14 INFO - PROCESS | 1675 | |i|pagename|runs| 21:23:14 INFO - PROCESS | 1675 | |0;ai-astar;122;169;158;114;112;112;112;112;113;112 21:23:14 INFO - PROCESS | 1675 | |1;audio-beat-detection;140;110;112;140;110;109;109;109;140;108 21:23:14 INFO - PROCESS | 1675 | |2;audio-dft;181;184;184;181;185;184;186;183;184;182 21:23:14 INFO - PROCESS | 1675 | |3;audio-fft;83;61;60;89;62;59;59;60;82;59 21:23:14 INFO - PROCESS | 1675 | |4;audio-oscillator;84;71;95;70;68;69;93;67;68;91 21:23:14 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;90;86;90;87;91;86;88;113;89;86 21:23:14 INFO - PROCESS | 1675 | |6;imaging-darkroom;95;96;95;95;94;95;95;95;93;94 21:23:14 INFO - PROCESS | 1675 | |7;imaging-desaturate;94;90;93;130;95;91;91;88;96;89 21:23:14 INFO - PROCESS | 1675 | |8;json-parse-financial;56;52;51;53;54;55;56;55;57;56 21:23:14 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;70;66;71;76;73;68;68;69;68;70 21:23:14 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;83;82;83;82;81;84;83;83;104;102 21:23:14 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;155;155;149;136;139;151;155;152;168;148 21:23:14 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;163;165;164;161;164;221;211;162;163;162 21:23:14 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;66;67;67;66;63;82;85;83;69;66 21:23:14 INFO - PROCESS | 1675 | __end_tp_report 21:23:14 INFO - PROCESS | 1675 | __start_cc_report 21:23:14 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1959 21:23:14 INFO - PROCESS | 1675 | __end_cc_report 21:23:14 INFO - PROCESS | 1675 | __startTimestamp1475814194582__endTimestamp 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | ------- Summary: start ------- 21:23:14 INFO - PROCESS | 1675 | Number of tests: 14 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:123.60 Median:113.50 stddev:21.41 (18.9%) stddev-sans-first:22.70 21:23:14 INFO - PROCESS | 1675 | Values: 122.0 169.0 158.0 114.0 112.0 112.0 112.0 112.0 113.0 112.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:118.70 Median:111.00 stddev:14.74 (13.3%) stddev-sans-first:13.46 21:23:14 INFO - PROCESS | 1675 | Values: 140.0 110.0 112.0 140.0 110.0 109.0 109.0 109.0 140.0 108.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:1.65 (0.9%) stddev-sans-first:1.50 21:23:14 INFO - PROCESS | 1675 | Values: 181.0 184.0 184.0 181.0 185.0 184.0 186.0 183.0 184.0 182.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:67.40 Median:61.50 stddev:12.08 (19.7%) stddev-sans-first:11.42 21:23:14 INFO - PROCESS | 1675 | Values: 83.0 61.0 60.0 89.0 62.0 59.0 59.0 60.0 82.0 59.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:77.50 stddev:11.70 (15.1%) stddev-sans-first:12.18 21:23:14 INFO - PROCESS | 1675 | Values: 84.0 71.0 95.0 70.0 68.0 69.0 93.0 67.0 68.0 91.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:90.60 Median:88.50 stddev:8.09 (9.1%) stddev-sans-first:8.57 21:23:14 INFO - PROCESS | 1675 | Values: 90.0 86.0 90.0 87.0 91.0 86.0 88.0 113.0 89.0 86.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:94.70 Median:95.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 21:23:14 INFO - PROCESS | 1675 | Values: 95.0 96.0 95.0 95.0 94.0 95.0 95.0 95.0 93.0 94.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:92.00 stddev:12.33 (13.4%) stddev-sans-first:13.06 21:23:14 INFO - PROCESS | 1675 | Values: 94.0 90.0 93.0 130.0 95.0 91.0 91.0 88.0 96.0 89.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.50 stddev:1.96 (3.5%) stddev-sans-first:2.00 21:23:14 INFO - PROCESS | 1675 | Values: 56.0 52.0 51.0 53.0 54.0 55.0 56.0 55.0 57.0 56.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:2.88 (4.1%) stddev-sans-first:3.06 21:23:14 INFO - PROCESS | 1675 | Values: 70.0 66.0 71.0 76.0 73.0 68.0 68.0 69.0 68.0 70.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:83.00 stddev:8.64 (10.4%) stddev-sans-first:9.06 21:23:14 INFO - PROCESS | 1675 | Values: 83.0 82.0 83.0 82.0 81.0 84.0 83.0 83.0 104.0 102.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:150.80 Median:153.50 stddev:8.94 (5.8%) stddev-sans-first:9.35 21:23:14 INFO - PROCESS | 1675 | Values: 155.0 155.0 149.0 136.0 139.0 151.0 155.0 152.0 168.0 148.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.60 Median:164.00 stddev:22.50 (13.7%) stddev-sans-first:23.54 21:23:14 INFO - PROCESS | 1675 | Values: 163.0 165.0 164.0 161.0 164.0 221.0 211.0 162.0 163.0 162.0 21:23:14 INFO - PROCESS | 1675 | 21:23:14 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:68.00 stddev:8.40 (12.3%) stddev-sans-first:8.67 21:23:14 INFO - PROCESS | 1675 | Values: 66.0 67.0 67.0 66.0 63.0 82.0 85.0 83.0 69.0 66.0 21:23:14 INFO - PROCESS | 1675 | -------- Summary: end -------- 21:23:14 INFO - PROCESS | 1675 | 21:23:15 INFO - TEST-INFO | 1675: exit 0 21:23:15 INFO - TEST-OK | kraken | took 58940ms 21:23:15 INFO - SUITE-END | took 1176s 21:23:15 INFO - Completed test suite (00:19:36) 21:23:15 INFO - javascript benchmark 21:23:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2774.625425567549, 3322.053214833772, 3341.3818443587925, 3354.84257931014, 3389.1018879996805, 5622.8313150605445, 5672.404397538261, 5683.516901063409, 5686.431356864311, 5719.542436605072, 5608.0, 5699.800506982257, 5707.14392841073, 5707.258056452655, 5741.569382296334, 5129.717865517395, 5150.150225212836, 5173.844784656466, 5186.118359878811, 5202.557782588485, 5110.744462776846, 5124.231365295198, 5129.0767661820855, 5252.8161514347, 5302.3637163540425, 4916.704997700132, 5116.951025039876, 5169.431362550116, 5183.948160518403, 5192.376914770233, 5172.431032586413, 5207.453217412193, 5243.711595862226, 5249.86875328116, 5304.6286759926825, 5057.8229761958155, 5108.080545501808, 5171.3535808024, 5190.480951904817, 5190.71451070191, 4541.296099104644, 5584.329880414376, 5658.377578466366, 5673.978683836907, 5688.232088668018, 6083.878322433527, 6098.420650038283, 6129.846753831145, 6141.78503752371, 6155.199824022893, 6209.441150296449, 6279.623222606659, 6282.465990390822, 6284.528660350446, 6290.62256264621, 5589.916151257735, 5643.971780141073, 5733.541316694655, 5775.335836378828, 5784.0, 6282.371762823681, 6286.182796236551, 6293.370662933761, 6301.117843501822, 6309.873802523924, 6149.84625384369, 6152.907706384408, 6157.076438534255, 6163.229596300463, 6181.84545386369, 6046.3349031606485, 6117.357677443893, 6138.478229350555, 6143.692815359214, 6266.467350275187, 6119.571629985859, 6122.265328160649, 6130.773845230971, 6132.417420345149, 6134.754609815646, 6096.390360963868, 6116.8227554565365, 6123.374132580163, 6136.938630613726, 6144.2319710036245, 4811.855644330676, 4872.8781780455065, 4875.731834749052, 4896.36347274852, 4920.0, 4381.079973205598, 4394.384786129945, 4410.80151393188, 4431.711938723973, 4440.62254708347, 5524.530414914697, 5623.268975033219, 5720.2849643794525, 5729.656220626775, 5733.684647344436, 5093.18509038552, 6154.353792851686, 6190.721417536221, 6223.688815559204, 6267.874642507124, 5714.3999880012, 5722.828315150552, 5728.656280623176, 5736.368999410061, 5772.0, 5334.946650533522, 5338.706371149624, 5348.1175606025345, 5360.678359298377, 5363.168708850135, 6207.16203312547, 6217.751289948442, 6224.751009959551, 6250.687465626791, 6267.373262673878, 6265.780697675559, 6270.435660790368, 6276.529260305587, 6292.024736165901, 6293.181886354744, 6271.059341098871, 6288.402601752826, 6289.779857704958, 6295.496360291258, 6299.685015749103, 5814.796482123105, 5914.172015917689, 6033.366496517802, 6062.484688801501, 6098.298695650057, 5253.921191182212, 5519.668819870821, 5964.791232307022, 6141.332587233645, 6223.066540019034, 5882.941070607332, 6020.1270815730595, 6029.547783916311, 6032.245969253843, 6035.094735789491, 4502.774861256989, 5716.971415142898, 5982.551308651781, 5992.700364981821, 6045.788397406246, 5837.824865254049, 5861.003629383101, 5863.413658634103, 5873.4126587340925, 5894.174815525744, 5951.404859514014, 6019.337872833898, 6032.215811944419, 6039.486643635164, 6040.6979651018155, 5692.686902220252, 5716.456936591017, 5831.679257640871, 5831.7375718093635, 5841.153032810304], "value": 5617.954896872996, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.2215505493463, 475.2989340722437, 475.3962467666064, 521.8434469659102, 542.701514167208, 26340.3414914627, 41496.0, 42752.78623606878, 42779.0, 44532.77733611327, 44057.11885762283, 44303.335449968275, 44357.556424435745, 44529.777351113284, 44595.0, 8864.955675221614, 9933.950330248339, 10105.242106842017, 10112.443815590139, 10121.746956326077, 8751.037385887546, 10244.385336879774, 12100.515979360815, 12303.938480307586, 12521.624351269476, 12199.451024703865, 12244.142909996304, 12248.571300004502, 12264.81602775959, 12266.81599776004, 12258.509659613605, 12338.938305308417, 12352.938235308855, 12372.752544949051, 12378.257304561665, 12193.329366884818, 12264.877351226463, 12277.938610306892, 12288.385580720927, 12322.75354492914, 41379.58620413818, 41736.37395439071, 41827.1634567307, 41837.79081104575, 41891.1621767563, 3318.2699806042633, 3836.693064554857, 4011.117554138085, 4026.4966879140106, 4038.172174704179, 30761.077167685005, 31353.37293254122, 32099.0, 32134.839325803456, 32987.0, 3248.5289633003317, 3261.869525218988, 3301.983490082558, 3322.684344987222, 3389.034125274285, 492816.0718392806, 494425.0, 497390.0, 498112.0, 502545.0, 33977.0, 34289.65710342915, 34631.30737385238, 62215.37784622096, 62738.686306568175, 35526.64473355285, 35665.64334356675, 35669.0, 35692.28615427677, 35753.10617234538, 13874.751272385534, 13974.441022358991, 14016.649583760487, 14040.578782636538, 14052.508162214273, 10238.18094552434, 10421.68734937953, 11508.424578771195, 11582.652520424232, 11593.710157246136, 5678.346990096109, 6465.612063276219, 7772.300492955661, 7809.960950195213, 7891.921080789233, 2881.351695868455, 3216.4371235033777, 3222.854971526287, 3229.289556297611, 3260.3805276997296, 826.9917300827035, 902.472053848506, 961.1301771896445, 976.7558110472382, 1011.726833754882, 29148.708512915022, 29887.551686724717, 30149.547756783664, 30870.38259234803, 31662.208444789063, 844.5903736687701, 1038.4911393417171, 1076.284270959803, 1102.211918478276, 1114.9331040137617, 14052.789208161887, 15562.265056386612, 15781.21093945321, 15856.44502442409, 16036.278367473491, 645948.0, 647759.0, 650074.0, 652560.0, 653888.8444462264, 58066.0, 58644.70677646584, 58662.12006819901, 58719.0, 58798.0, 1208.2871106047298, 1241.075398827879, 1306.3076569418224, 1334.3528388731459, 1369.5069774880835, 30776.69223307738, 30900.0, 31921.840390797897, 32021.35957280795, 32499.512507312884, 49264.26103608377, 49595.25607115824, 49812.501874980786, 49849.50150498449, 49855.252171216736, 515180.0, 516616.0, 518269.0, 518397.0, 519837.0, 26986.05548805861, 27277.727222728314, 27483.450330993666, 27612.861935690195, 27878.58182127229, 47229.52770472251, 47866.0, 48018.0, 48629.5137048625, 48746.0, 33371.83314083414, 39242.2151556973, 40217.79891100526, 41121.0, 41723.956901076504, 33533.16167095842, 39461.80269098751, 39484.802575986934, 39819.0, 39828.00429989273, 37951.81024094862, 38992.80503597464, 39000.6099938997, 39063.0, 39222.411663824496, 34115.82942085274, 35071.0, 35129.64870351264, 35575.288494229455, 35791.46312805258, 25842.0, 25854.482910342063, 25979.350516237246, 26272.868635656698, 26439.0], "value": 19005.430418407395, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.28055687233365, 372.47481051717074, 373.71410870683917, 383.7102987244631, 399.504614278295, 15302.158381289039, 15680.686386272268, 17357.30570777169, 20807.895960520174, 21218.0, 20528.794712052873, 20814.791852081475, 21131.57736845262, 21382.465438364008, 21584.784152158474, 5898.616589921641, 5937.821865344025, 6091.0863370494335, 6225.0, 6233.376662333753, 4229.323308270677, 6077.878442431149, 6190.195274614316, 6197.659128747917, 6205.7517699291975, 4440.42274504314, 6503.349665033506, 6800.761973330935, 6829.795106146824, 6925.238223795403, 5734.197212390269, 6063.757449702007, 6115.266168059861, 6887.932370482558, 6932.584044957293, 5939.792107276225, 5941.881162376728, 5942.851428714317, 5943.227380440559, 5945.583809133363, 12626.368681565977, 12728.98168146546, 12903.87096129036, 13078.86921130786, 13430.328483575782, 2174.717286752712, 2267.263139479659, 2510.272021113875, 2799.7340252675963, 2826.010896186339, 9999.700008999742, 10136.087752102272, 10331.0, 10990.890091099067, 16192.676146477123, 1867.7385166076624, 1909.5417099896065, 1912.6270377276437, 1936.8256856882808, 1944.0182707732504, 91427.0, 112106.0, 112364.0, 121730.39134804357, 122093.38953305266, 9260.610908363664, 11186.049185819296, 11312.26695190585, 11512.424378781028, 11714.1800073994, 14471.986960912634, 14496.492622758153, 14512.564623061326, 14520.201388923499, 14545.0, 7873.448858579959, 8196.221358970888, 8212.753617391369, 8280.668773249123, 8289.709860154866, 7874.0, 7876.448648594544, 7897.565633890191, 8041.477303975223, 8054.798630034296, 4510.188166130128, 4514.864554063383, 4530.29780384041, 4534.115847409724, 4589.449266088091, 1779.9377021804175, 1795.778870368136, 1887.8867267963967, 1957.377114666354, 1969.3107412405543, 828.5443006346485, 873.6636394987848, 875.2035647560816, 900.7297810656777, 954.6372378496266, 20148.597028059357, 21614.459638508848, 21641.891790540947, 21680.783192168194, 21687.89156054241, 908.205972022504, 914.6112902016749, 917.1928702741678, 931.6087243357806, 992.1269283030887, 10361.948190259, 11378.54485820558, 11463.082953363712, 11469.942650286863, 11487.597934072268, 580078.0, 590314.0, 592501.0, 592635.0, 592946.0, 125989.0, 129299.35350323377, 130502.0, 131174.0, 136669.31665341608, 935.251798561162, 941.9905800941902, 967.0716112532048, 967.2503809547657, 968.0899954043177, 18695.439136825917, 18951.957642329253, 19163.712544312126, 19209.0, 19248.903755481133, 47225.527744722116, 53611.731941341604, 54933.450665492834, 55154.06960756354, 55324.06365777178, 76697.61651191708, 81311.0, 81703.77444338221, 83717.58141209255, 84283.31433371421, 6688.632125233159, 7948.721794737156, 8039.598020099089, 8057.637406316612, 8369.0375606806, 8978.506182159783, 13084.542041028519, 13180.604581862559, 13240.0, 13448.93275533616, 11186.440677966231, 11299.604513841976, 11460.255083419552, 11624.360660163435, 11663.300201987908, 9571.1864491519, 11004.284721493077, 11229.0, 11339.149563782914, 11496.712582185512, 9053.818923621358, 11458.968692817687, 11642.76714465689, 11750.353730544903, 12009.39953002329, 6905.37851593359, 8028.959855200686, 8060.596970151351, 8293.543855088028, 8396.370272229486, 8285.4200205985, 10738.355698658106, 11293.548258069584, 11372.488238029475, 11559.722902526119], "value": 9425.371345507117, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1385.764420048593, 1541.044552377526, 1541.6454215530428, 1720.1915099903042, 1867.8132186781315, 7865.488743231693, 8406.957965210173, 8744.169303916135, 8929.642814287421, 8932.910670893289, 7549.320561149495, 8855.468671879675, 8898.332625053115, 8918.063603321654, 8964.058773828752, 2392.521495700858, 2424.696912885889, 2426.38127277544, 2427.9514409711796, 2432.671589335435, 2373.738888722239, 2417.2144053182697, 2425.223928342931, 2428.659987601737, 2433.768791964769, 2135.765065842756, 2356.5389458535647, 2392.83250172488, 2420.4070002849326, 2432.428379330856, 2370.111208296889, 2386.224477044959, 2396.9932628295983, 2402.363373705978, 2408.2173293679625, 2351.5296940611775, 2384.6065399209283, 2386.296042667417, 2390.3307074019303, 2398.0527691561733, 8635.784105397352, 8825.51459669718, 8852.822943541094, 8934.910650893473, 8947.821043579092, 5368.087425137736, 5525.889482210374, 5536.0, 5544.972275138639, 5559.694216818073, 3601.1897323102353, 3652.8356223969986, 3665.5234819473562, 3719.851205951759, 3721.4789929409903, 1100.928439651428, 1110.4725255503652, 1116.3246236027248, 1119.1438549509633, 1135.2904434728296, 11769.705757356049, 11782.0, 11823.645290641294, 11828.0, 11840.407979600985, 4411.625011874026, 4517.435320584927, 4675.742834144086, 4716.481187069488, 4724.291356296583, 9192.402493837879, 9210.401323913924, 9224.30817688676, 9225.86161207569, 9230.953845230732, 5304.708241046779, 5306.97346513265, 5307.416184219733, 5311.840644780663, 5322.707251101149, 4183.330667093251, 4422.889427764268, 4556.111558246176, 4583.289590113538, 4936.555709986119, 3853.653171214548, 3864.53625564934, 3918.1380096378753, 3933.567307596162, 3936.075022369741, 1161.6524831195773, 1172.806486929664, 1180.5100883133575, 1182.296533562546, 1197.5150064224003, 700.8423104801379, 893.093510087262, 908.42315129893, 924.5977999570208, 931.1479995803899, 5686.118651609007, 5859.267591551056, 5909.438603332676, 6037.305709843336, 6124.081387791867, 432.7338686707652, 433.9197248508973, 448.854122410218, 463.6615270852297, 465.06289826000636, 3914.5693973662874, 3942.7634341939574, 4104.570231440578, 4197.496300443966, 4212.431321771583, 9272.443653380818, 10891.509882055327, 10981.890181098246, 11004.339739615649, 11004.614838480615, 10939.890601093886, 10951.397673127894, 10957.945210274058, 10974.780504389868, 11033.393163376091, 6775.288594697585, 8195.7951051223, 8207.384446166561, 8440.957795211107, 8451.492910425393, 5940.138679891478, 5958.493528050164, 6004.808244990634, 6063.211782468427, 6084.513238940785, 9800.607975680892, 9962.0, 10191.133753630727, 10211.591536338761, 10213.897861021593, 9465.47939863314, 10160.390376577428, 10288.12550933179, 10376.066154046172, 10464.738381540523, 6988.720451181895, 7428.9628551856895, 7565.43259255547, 7639.88540171909, 7746.65140068687, 8287.50274983503, 8302.0, 8320.70877519284, 8388.119247479171, 8418.368622353226, 7508.511946723445, 7571.848563028599, 7603.847923041619, 7642.0065391500975, 7648.541087534766, 7387.1135463744695, 7392.186859445349, 7407.370373518312, 7415.777526674208, 7487.47587668858, 6730.663466826737, 6929.930700692928, 6975.337342952412, 7001.0, 7003.7548685795755, 5112.182050871843, 5133.486651334837, 5153.922691159561, 5313.096773548429, 5313.681179129265, 5151.793928242828, 5175.560077393464, 5244.580433565229, 5306.097963346318, 5389.811356602657], "value": 4517.02639256889, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.8410842253606, 300.59569878513406, 307.92455848317167, 313.3795085730254, 314.59260257965934, 4724.31497432872, 4903.926441103386, 4994.775235114419, 5212.93134907344, 5407.05376559102, 4458.4426946631675, 5080.212567052104, 5135.895782406791, 5175.870603234921, 5370.865728356793, 4058.701215611006, 4068.4304197412384, 4094.795260236991, 4100.52843922949, 4113.321301985184, 3902.0, 4046.6560342370935, 4057.5942405759483, 4076.6331030207275, 4106.837734944106, 3709.7959612221316, 3943.3690609502487, 3994.960050399488, 4061.4110953911663, 4088.325426304671, 3868.0, 3965.1871366369824, 3972.741771784825, 3977.5425826030087, 3991.2416640838146, 3412.4540073588105, 3428.9828550857337, 3432.318164099573, 3465.376232278189, 3473.2532505511435, 4231.576842315774, 4613.1696294666945, 5107.080725469414, 5145.819896303611, 5160.25176349431, 4500.324951257305, 4505.5719706627815, 4510.819567217307, 4550.726956382628, 4558.948473187046, 4882.389701287339, 5081.237814327844, 5421.241026256327, 5437.32033495813, 5494.532964698005, 2828.8444135572536, 3140.685931406864, 3787.261484010619, 3803.76377677256, 3835.0, 5355.544778693816, 5746.88506229873, 5750.367459579443, 5786.971065144689, 5818.981678206297, 3300.1089705779304, 3319.7842140260805, 3459.5296998775925, 3845.9615403846165, 3846.442265871489, 3874.4769456123627, 3877.903052423712, 3894.520082368682, 3928.3910993796007, 3951.0, 4234.898926279128, 4427.432089388147, 4569.657275704269, 4594.439309535071, 4615.423072115986, 5536.972315138399, 5545.61180717354, 5559.916601250984, 5562.0, 5598.1322894951345, 1170.7297582123322, 1252.5177806544364, 1264.4120483974996, 1292.8707129286995, 1306.9346532673328, 723.9683451082187, 847.1824689174853, 859.5873980489275, 895.4269267668698, 902.8420026495337, 4375.562443755599, 5184.481551844785, 5191.896162076813, 5196.454372290855, 5250.868728281824, 4693.647976401715, 5078.923816142761, 5671.0, 5684.715764211773, 5710.942890571124, 4381.868543943623, 4579.824583322895, 5296.92054619181, 5360.354958628092, 5366.221897824794, 2632.3550730071256, 2686.489566982267, 2947.3073827650487, 2981.4037192561573, 3025.6400007993802, 5274.077036518671, 5616.719164041863, 5970.044792833126, 6006.759729610854, 6029.155918171459, 5064.873378165576, 5362.463753624685, 5789.88420231593, 5928.318243402064, 5937.2578427696535, 4847.442544107403, 5490.835274941758, 5530.253415788898, 5889.793857215062, 5974.4324289192455, 4047.1096358801015, 5550.972245138749, 5738.876615652235, 5740.249223986557, 5825.2135961644635, 5686.360729133441, 5703.686297253525, 5707.68607726579, 5720.885582288414, 5720.970225359475, 5535.0313695104005, 5935.2877654681715, 5956.183364073999, 5957.463828255478, 6043.486303664238, 3429.2627085176805, 3708.2768860073106, 4025.67794576439, 4036.555978842384, 4045.4943132108488, 5170.3278573785165, 5201.791928322976, 5370.704611246263, 5773.624714393551, 5787.2187254720075, 5307.169026685787, 5634.774609015593, 5641.617803638135, 5643.134452899777, 5653.2085508028085, 4939.456659767495, 5185.870353241199, 5537.584681148849, 5568.248286481273, 5596.664200148004, 4673.9298910517045, 5145.536901678867, 5289.047971365191, 5368.1679339702405, 5442.809501667422, 4748.667593268438, 4979.178435558092, 5207.453217412269, 5372.7582258797665, 5477.561795056466, 5425.782968681367, 5438.293021907127, 5452.400235974119, 5453.972730136324, 5474.562035037108], "value": 4040.3163920442544, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [780.4848799792138, 789.6643926331311, 792.3186059988412, 818.6397984886652, 829.900411950566, 12143.878561214397, 14975.326110325035, 15013.699726005487, 15050.172240526766, 15058.322375493102, 13207.141535800167, 13230.735385292312, 13294.601161965133, 13477.865221347784, 13689.520866769664, 813.0730966697969, 839.4082172068677, 840.6385254340631, 841.3395484544634, 842.2251528593678, 671.3957438305515, 691.2707094015811, 814.2834305810908, 840.3319361107934, 845.1337379186352, 888.6090120347027, 889.0398369760643, 890.4034297021011, 890.9643614255422, 892.6474042753109, 881.312576190566, 881.9867701984443, 882.6204731965253, 883.0374891368375, 883.483162350026, 421.8755467137202, 522.5245027025388, 633.0883527720068, 649.1009951217551, 651.7295322441181, 13927.442902283896, 13969.3713782879, 13994.510192143329, 13999.020068595202, 14019.228942408163, 12476.001919846482, 12538.373081345897, 12638.55765048219, 12648.936755316165, 12827.583470549733, 11735.0, 11851.644450666494, 11960.760784784343, 12184.268943863397, 12421.1926224796, 4349.760763158025, 4451.933221001687, 4593.425821772278, 4597.195490789132, 4609.723416595015, 113209.0, 114333.99999999917, 114341.85658143478, 114367.0, 121120.0, 10143.391396516232, 10216.897831021595, 10323.896761032443, 10474.581016759244, 10629.4153821539, 19305.131269092926, 19312.71030934537, 19315.130819112892, 19328.323508677127, 19334.323298684478, 7203.459740519482, 7316.817079573053, 7340.632968351668, 7410.370118539877, 7454.068241469817, 4127.236461254677, 4183.456150700389, 4224.408582798411, 4342.131573685212, 4414.933775993362, 3189.473736833443, 3222.6616205298574, 3272.214668479548, 3273.6235332937017, 3278.246003419227, 633.5691729623808, 637.4517914593446, 645.4642646603309, 656.0913135307634, 658.1444122640548, 533.5491509674318, 549.6894254746136, 598.5600583571072, 632.8670979094442, 634.6731433311755, 7903.68385264583, 8676.8698469523, 8797.29621630268, 8798.0, 9072.0, 609.7926704920349, 621.5959626242887, 642.9099926010363, 675.9425448836904, 704.8836941904631, 4182.581741825793, 4395.53846846083, 4412.0, 4461.464624245112, 4578.5650363215445, 95772.0, 118876.40561797135, 129315.0, 150447.99104017857, 155859.0, 121725.39137304257, 126089.73910260963, 126233.36883315709, 130527.0, 130649.34675326562, 100273.49863250637, 105967.47016264715, 107946.46026769816, 110371.89628103616, 114219.42890285495, 7360.4479664026485, 8129.187081291823, 8194.262516373556, 8426.789330266793, 8734.126587341469, 60330.69834650798, 60433.69783151056, 60464.418726723525, 61664.69167654133, 63150.68424657847, 76859.0, 90682.66466691664, 94908.0, 96557.0, 97043.0, 10886.129109671048, 10953.83569246478, 11254.606088786853, 11347.148963827582, 11587.957083862493, 12009.459574319351, 12012.519499219934, 12329.69175770577, 12449.751004980031, 12467.688307792016, 10871.565137394417, 11501.194916355775, 11918.225315354473, 12070.396480175781, 12336.753264934472, 11393.886061139283, 11855.822162667739, 11980.28118312904, 12070.0, 12110.673503257009, 11319.377434241196, 11690.357030363411, 11922.344271065174, 12429.875701242872, 12464.0, 9199.954000229956, 9265.53672316395, 9958.502074896081, 10050.949745251519, 10111.89888101139, 9412.67055653049, 9838.852417213891, 9866.950665246628, 9868.161206297546, 9906.554205060645], "value": 7373.492416841036, "unit": "score"}], "name": "dromaeo_css", "value": 7166.219964489402, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 169.0, 158.0, 114.0, 112.0, 112.0, 112.0, 112.0, 113.0, 112.0], "value": 123.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 110.0, 112.0, 140.0, 110.0, 109.0, 109.0, 109.0, 140.0, 108.0], "value": 118.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 184.0, 181.0, 185.0, 184.0, 186.0, 183.0, 184.0, 182.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 60.0, 89.0, 62.0, 59.0, 59.0, 60.0, 82.0, 59.0], "value": 67.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 71.0, 95.0, 70.0, 68.0, 69.0, 93.0, 67.0, 68.0, 91.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 87.0, 91.0, 86.0, 88.0, 113.0, 89.0, 86.0], "value": 90.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 93.0, 94.0], "value": 94.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 90.0, 93.0, 130.0, 95.0, 91.0, 91.0, 88.0, 96.0, 89.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 52.0, 51.0, 53.0, 54.0, 55.0, 56.0, 55.0, 57.0, 56.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 71.0, 76.0, 73.0, 68.0, 68.0, 69.0, 68.0, 70.0], "value": 69.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 83.0, 82.0, 81.0, 84.0, 83.0, 83.0, 104.0, 102.0], "value": 86.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 155.0, 149.0, 136.0, 139.0, 151.0, 155.0, 152.0, 168.0, 148.0], "value": 150.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 161.0, 164.0, 221.0, 211.0, 162.0, 163.0, 162.0], "value": 173.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 63.0, 82.0, 85.0, 83.0, 69.0, 66.0], "value": 71.4, "unit": "score"}], "name": "kraken", "value": 1458.6000000000001, "alertThreshold": 2.0}]} 21:23:15 INFO - Return code: 0 21:23:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:23:15 INFO - # TBPL SUCCESS # 21:23:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:23:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:23:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:23:15 INFO - 2016-10-06 21:23:15.899 screenresolution[1679:11472] starting screenresolution argv=screenresolution get 21:23:15 INFO - 2016-10-06 21:23:15.902 screenresolution[1679:11472] Display 0: 1600x1200x32@60 21:23:15 INFO - 2016-10-06 21:23:15.908 screenresolution[1680:11477] starting screenresolution argv=screenresolution list 21:23:15 INFO - Available Modes on Display 0 21:23:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:23:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:23:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:23:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:23:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:23:16 INFO - Intel Iris: 21:23:16 INFO - Chipset Model: Intel Iris 21:23:16 INFO - Type: GPU 21:23:16 INFO - Bus: Built-In 21:23:16 INFO - VRAM (Dynamic, Max): 1536 MB 21:23:16 INFO - Vendor: Intel (0x8086) 21:23:16 INFO - Device ID: 0x0a2e 21:23:16 INFO - Revision ID: 0x0009 21:23:16 INFO - Displays: 21:23:16 INFO - Display: 21:23:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:23:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:23:16 INFO - Display Serial Number: 1600x1200 60 21:23:16 INFO - Main Display: Yes 21:23:16 INFO - Mirror: Off 21:23:16 INFO - Online: Yes 21:23:16 INFO - Rotation: Supported 21:23:16 INFO - Return code: 0 21:23:16 INFO - Running post-action listener: _resource_record_post_action 21:23:16 INFO - [mozharness: 2016-10-07 04:23:16.145065Z] Finished run-tests step (success) 21:23:16 INFO - Running post-run listener: _resource_record_post_run 21:23:16 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 31964160; Write bytes: 664414720; Read time: 195; Write time: 1890 21:23:16 INFO - TinderboxPrint: CPU usage
53.2% 21:23:16 INFO - TinderboxPrint: I/O read bytes / time
31,964,160 / 195 21:23:16 INFO - TinderboxPrint: I/O write bytes / time
664,414,720 / 1,890 21:23:16 INFO - TinderboxPrint: CPU idle
2,268.2 (46.8%) 21:23:16 INFO - TinderboxPrint: CPU system
965.4 (19.9%) 21:23:16 INFO - TinderboxPrint: CPU user
1,608.2 (33.2%) 21:23:16 INFO - TinderboxPrint: Swap in / out
390,823,936 / 0 21:23:16 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 358201856; Write bytes: 356300800; Read time: 28791; Write time: 733 21:23:16 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 30206976; Write bytes: 297091584; Read time: 181; Write time: 1120 21:23:16 INFO - Running post-run listener: _upload_blobber_files 21:23:16 INFO - Blob upload gear active. 21:23:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:23:16 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 21:23:16 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'] 21:23:16 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 21:23:17 INFO - (blobuploader) - INFO - Open directory for files ... 21:23:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:23:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:23:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:17 INFO - (blobuploader) - INFO - Done attempting. 21:23:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:23:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:23:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:18 INFO - (blobuploader) - INFO - Done attempting. 21:23:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:23:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:23:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:22 INFO - (blobuploader) - INFO - Done attempting. 21:23:22 INFO - (blobuploader) - INFO - Iteration through files over. 21:23:22 INFO - Return code: 0 21:23:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:23:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:23:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/551916dfd1cc8c5df81f2d7d6b23a657fcba0015f617e1acd59efbcf99b95c50d280c43888a4b6b2f866787fdf6c5ab5a8f126f17f1d15751c6330fbffa44ec1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7013cf1562b2c6733a5b8c7775bd320e64cd6886c411b18b4ff99647d9c53c7da15415f6945ba5f7054550d3f7ae4c8636da87d9de5794424bc7cb09019f806b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ffa5df61f185cdf05481afe70201a6e4577b6cb9464a7cb469a01034370e8ca6dd1b893f234de0d642f7d4646c2e3ee3b985dd1dd85b9a0a4019983f6c43367"} 21:23:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:23:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:23:22 INFO - Contents: 21:23:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/551916dfd1cc8c5df81f2d7d6b23a657fcba0015f617e1acd59efbcf99b95c50d280c43888a4b6b2f866787fdf6c5ab5a8f126f17f1d15751c6330fbffa44ec1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7013cf1562b2c6733a5b8c7775bd320e64cd6886c411b18b4ff99647d9c53c7da15415f6945ba5f7054550d3f7ae4c8636da87d9de5794424bc7cb09019f806b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ffa5df61f185cdf05481afe70201a6e4577b6cb9464a7cb469a01034370e8ca6dd1b893f234de0d642f7d4646c2e3ee3b985dd1dd85b9a0a4019983f6c43367"} 21:23:22 INFO - Running post-run listener: copy_logs_to_upload_dir 21:23:22 INFO - Copying logs to upload dir... 21:23:22 INFO - mkdir: /builds/slave/test/build/upload/logs 21:23:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.171872 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-10-06 21:23:22.767411) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:23:22.774213) ========= 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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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/551916dfd1cc8c5df81f2d7d6b23a657fcba0015f617e1acd59efbcf99b95c50d280c43888a4b6b2f866787fdf6c5ab5a8f126f17f1d15751c6330fbffa44ec1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7013cf1562b2c6733a5b8c7775bd320e64cd6886c411b18b4ff99647d9c53c7da15415f6945ba5f7054550d3f7ae4c8636da87d9de5794424bc7cb09019f806b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ffa5df61f185cdf05481afe70201a6e4577b6cb9464a7cb469a01034370e8ca6dd1b893f234de0d642f7d4646c2e3ee3b985dd1dd85b9a0a4019983f6c43367"} build_url:https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011063 build_url: 'https://queue.taskcluster.net/v1/task/a-LGjJ8iRq6kUxdIdDm85Q/artifacts/public/build/firefox-51.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/551916dfd1cc8c5df81f2d7d6b23a657fcba0015f617e1acd59efbcf99b95c50d280c43888a4b6b2f866787fdf6c5ab5a8f126f17f1d15751c6330fbffa44ec1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7013cf1562b2c6733a5b8c7775bd320e64cd6886c411b18b4ff99647d9c53c7da15415f6945ba5f7054550d3f7ae4c8636da87d9de5794424bc7cb09019f806b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ffa5df61f185cdf05481afe70201a6e4577b6cb9464a7cb469a01034370e8ca6dd1b893f234de0d642f7d4646c2e3ee3b985dd1dd85b9a0a4019983f6c43367"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-06 21:23:22.806648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:23:22.807009) ========= 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.ZRYgs5H3W3/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.hFJBcUgWno/Listeners TMPDIR=/var/folders/r7/1plmn1y93dqbchyb2n9pp0r800000w/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.005172 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-06 21:23:22.855399) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:23:22.855712) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-06 21:23:22.856077) ========= ========= Total master_lag: 0.23 =========