builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0295 starttime: 1485165906.67 results: success (0) buildid: 20170123004004 builduid: c50289cf99724f65990a187417e962aa revision: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:06.673495) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:06.674217) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:06.675021) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:06.750901) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:06.751277) ========= 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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-23 02:05:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2017-01-23 02:05:06 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.169705 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:06.945213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:06.945527) ========= 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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.027642 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:06.997891) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 02:05:06.998199) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 24a81d93e07cc96300f8e1f5c69034dd4743bd63 --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 24a81d93e07cc96300f8e1f5c69034dd4743bd63 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2rSNmIjNpx/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.6aqN1XhNiO/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-23 02:05:07,121 truncating revision to first 12 chars 2017-01-23 02:05:07,121 Setting DEBUG logging. 2017-01-23 02:05:07,121 attempt 1/10 2017-01-23 02:05:07,121 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/24a81d93e07c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-23 02:05:08,202 unpacking tar archive at: mozilla-aurora-24a81d93e07c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.358554 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-23 02:05:08.385747) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:08.386053) ========= script_repo_revision: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:08.386455) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:08.386784) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-23 02:05:08.406933) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-23 02:05:08.407333) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.2rSNmIjNpx/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.6aqN1XhNiO/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:05:08 INFO - MultiFileLogger online at 20170123 02:05:08 in /builds/slave/test 02:05:08 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 02:05:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:05:08 INFO - {'append_to_log': False, 02:05:08 INFO - 'base_work_dir': '/builds/slave/test', 02:05:08 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:05:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:05:08 INFO - 'branch': 'Mozilla-Aurora', 02:05:08 INFO - 'buildbot_json_path': 'buildprops.json', 02:05:08 INFO - 'config_files': ('talos/mac_config.py',), 02:05:08 INFO - 'default_actions': ('clobber', 02:05:08 INFO - 'read-buildbot-config', 02:05:08 INFO - 'download-and-extract', 02:05:08 INFO - 'populate-webroot', 02:05:08 INFO - 'create-virtualenv', 02:05:08 INFO - 'install', 02:05:08 INFO - 'run-tests'), 02:05:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:05:08 INFO - 'download_minidump_stackwalk': True, 02:05:08 INFO - 'download_symbols': 'ondemand', 02:05:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:05:08 INFO - 'tooltool.py': '/tools/tooltool.py', 02:05:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:05:08 INFO - '/tools/misc-python/virtualenv.py')}, 02:05:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:05:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:05:08 INFO - 'installer_path': 'installer.exe', 02:05:08 INFO - 'log_level': 'info', 02:05:08 INFO - 'log_name': 'talos', 02:05:08 INFO - 'log_to_console': True, 02:05:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:05:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:05:08 INFO - 'opt_config_files': (), 02:05:08 INFO - 'pip_index': False, 02:05:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:05:08 INFO - 'cmd': ('bash', 02:05:08 INFO - '-c', 02:05:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:05:08 INFO - 'enabled': True, 02:05:08 INFO - 'halt_on_failure': False, 02:05:08 INFO - 'name': 'check_screen_resolution'},), 02:05:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:05:08 INFO - 'cmd': ('bash', 02:05:08 INFO - '-c', 02:05:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:05:08 INFO - 'enabled': True, 02:05:08 INFO - 'halt_on_failure': False, 02:05:08 INFO - 'name': 'check_screen_resolution'},), 02:05:08 INFO - 'run_cmd_checks_enabled': True, 02:05:08 INFO - 'sps_profile': False, 02:05:08 INFO - 'sps_profile_interval': 0, 02:05:08 INFO - 'suite': 'dromaeojs', 02:05:08 INFO - 'system_bits': '32', 02:05:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:05:08 INFO - 'title': 't-yosemite-r7-0295', 02:05:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:05:08 INFO - 'use_talos_json': True, 02:05:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:05:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:05:08 INFO - 'work_dir': 'build'} 02:05:08 INFO - [mozharness: 2017-01-23 10:05:08.626748Z] Running clobber step. 02:05:08 INFO - Running pre-action listener: _resource_record_pre_action 02:05:08 INFO - Running main action method: clobber 02:05:08 INFO - rmtree: /builds/slave/test/build 02:05:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:05:11 INFO - Running post-action listener: _resource_record_post_action 02:05:11 INFO - [mozharness: 2017-01-23 10:05:11.072487Z] Finished clobber step (success) 02:05:11 INFO - [mozharness: 2017-01-23 10:05:11.072728Z] Running read-buildbot-config step. 02:05:11 INFO - Running pre-action listener: _resource_record_pre_action 02:05:11 INFO - Running main action method: read_buildbot_config 02:05:11 INFO - Using buildbot properties: 02:05:11 INFO - { 02:05:11 INFO - "project": "", 02:05:11 INFO - "product": "firefox", 02:05:11 INFO - "script_repo_revision": "production", 02:05:11 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 02:05:11 INFO - "repository": "", 02:05:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 02:05:11 INFO - "buildid": "20170123004004", 02:05:11 INFO - "stage_platform": "macosx64", 02:05:11 INFO - "basedir": "/builds/slave/test", 02:05:11 INFO - "nightly_build": "True", 02:05:11 INFO - "buildnumber": 44, 02:05:11 INFO - "slavename": "t-yosemite-r7-0295", 02:05:11 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 02:05:11 INFO - "platform": "yosemite_r7", 02:05:11 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 02:05:11 INFO - "branch": "mozilla-aurora", 02:05:11 INFO - "repo_path": "releases/mozilla-aurora", 02:05:11 INFO - "revision": "24a81d93e07cc96300f8e1f5c69034dd4743bd63", 02:05:11 INFO - "pgo_build": "False", 02:05:11 INFO - "builduid": "c50289cf99724f65990a187417e962aa", 02:05:11 INFO - "slavebuilddir": "test" 02:05:11 INFO - } 02:05:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 02:05:11 INFO - Running post-action listener: _resource_record_post_action 02:05:11 INFO - [mozharness: 2017-01-23 10:05:11.078732Z] Finished read-buildbot-config step (success) 02:05:11 INFO - [mozharness: 2017-01-23 10:05:11.078922Z] Running download-and-extract step. 02:05:11 INFO - Running pre-action listener: _resource_record_pre_action 02:05:11 INFO - Running main action method: download_and_extract 02:05:11 INFO - mkdir: /builds/slave/test/build/tests 02:05: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')]} 02:05:11 INFO - trying https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 02:05:11 INFO - Downloading https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:05:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 02:05:12 INFO - Downloaded 1199 bytes. 02:05:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 02:05:12 INFO - Using the following test package requirements: 02:05:12 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:05:12 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:05:12 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 02:05:12 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:05:12 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 02:05:12 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:05:12 INFO - u'jsshell-mac.zip'], 02:05:12 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:05:12 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 02:05:12 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 02:05:12 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:05:12 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 02:05:12 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:05:12 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 02:05:12 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:05:12 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 02:05:12 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 02:05:12 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 02:05:12 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 02:05:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:05:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:05:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:05:12 INFO - Http code: 200 02:05:12 INFO - via: 1.1 e2af8a85927835558866752f53562ecd.cloudfront.net (CloudFront) 02:05:12 INFO - x-amz-cf-id: 1x9FWTKRACxDjbw20qizFRHGur-RC-Ljuour3xDg50wixTiEtf9t4A== 02:05:12 INFO - x-amz-version-id: xuXiIoTIKcRjmZ0Au8nQuM6QjEZ5_TBx 02:05:13 INFO - Expected file size: 16277638 02:05:13 INFO - Obtained file size: 16277638 02:05:20 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 02:05:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 02:05:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 02:05:20 INFO - Fetch https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 02:05:20 INFO - Http code: 200 02:05:20 INFO - via: 1.1 1b52a5dd431f9e3c81753e61dfdf467a.cloudfront.net (CloudFront) 02:05:20 INFO - x-amz-cf-id: spKdVz-kyIocZiDyUYLxSOoh5iDL0bKDddFSo6DKVHR_d4mapYiViA== 02:05:20 INFO - x-amz-version-id: xuXiIoTIKcRjmZ0Au8nQuM6QjEZ5_TBx 02:05:21 INFO - Expected file size: 16277638 02:05:21 INFO - Obtained file size: 16277638 02:05:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 02:05:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 02:05:27 INFO - Fetch https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 02:05:28 INFO - Http code: 200 02:05:28 INFO - via: 1.1 93ab344e1a3fa44edbf3f1bc5729427a.cloudfront.net (CloudFront) 02:05:28 INFO - x-amz-cf-id: 5ouzzjgPZ20ET1OtvbQigrLQOe5K5hJcFKU8w6lo_O5cMAI3q-QtRg== 02:05:28 INFO - x-amz-version-id: E9uJvFS8dJBbNkSwyZ9OyygU8nSm7stF 02:05:28 INFO - Expected file size: 14402992 02:05:28 INFO - Obtained file size: 14402992 02:05: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')]} 02:05:29 INFO - trying https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:05:29 INFO - Downloading https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 02:05:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 02:05:33 INFO - Downloaded 110778285 bytes. 02:05:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:05:33 INFO - mkdir: /builds/slave/test/properties 02:05:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:05:33 INFO - Writing to file /builds/slave/test/properties/build_url 02:05:33 INFO - Contents: 02:05:33 INFO - build_url:https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 02:05:33 INFO - Running post-action listener: _resource_record_post_action 02:05:33 INFO - Running post-action listener: set_extra_try_arguments 02:05:33 INFO - [mozharness: 2017-01-23 10:05:33.729840Z] Finished download-and-extract step (success) 02:05:33 INFO - [mozharness: 2017-01-23 10:05:33.729991Z] Running populate-webroot step. 02:05:33 INFO - Running pre-action listener: _resource_record_pre_action 02:05:33 INFO - Running main action method: populate_webroot 02:05:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:05:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:05:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:05:33 INFO - '--tppagecycles', 02:05:33 INFO - '7'], 02:05:33 INFO - 'tests': ['tsvgm']}}, 02:05:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:05:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:05:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:05:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:05:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:33 INFO - 'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:05:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:33 INFO - 'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['damp', 'tps']}, 02:05:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:33 INFO - 'tests': ['damp', 'tps']}, 02:05:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['dromaeo_dom']}, 02:05:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:05:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['basic_compositor_video']}, 02:05:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 02:05:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['a11yr', 02:05:33 INFO - 'ts_paint', 02:05:33 INFO - 'tpaint', 02:05:33 INFO - 'sessionrestore', 02:05:33 INFO - 'sessionrestore_no_auto_restore', 02:05:33 INFO - 'tabpaint']}, 02:05:33 INFO - 'other-e10s': {'tests': ['a11yr', 02:05:33 INFO - 'ts_paint', 02:05:33 INFO - 'tpaint', 02:05:33 INFO - 'sessionrestore', 02:05:33 INFO - 'sessionrestore_no_auto_restore', 02:05:33 INFO - 'tabpaint']}, 02:05:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:05:33 INFO - 'ts_paint', 02:05:33 INFO - 'tpaint', 02:05:33 INFO - 'sessionrestore', 02:05:33 INFO - 'sessionrestore_no_auto_restore', 02:05:33 INFO - 'tabpaint']}, 02:05:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:05:33 INFO - 'ts_paint', 02:05:33 INFO - 'tpaint', 02:05:33 INFO - 'sessionrestore', 02:05:33 INFO - 'sessionrestore_no_auto_restore', 02:05:33 INFO - 'tabpaint']}, 02:05:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['a11yr', 02:05:33 INFO - 'ts_paint', 02:05:33 INFO - 'tpaint', 02:05:33 INFO - 'sessionrestore', 02:05:33 INFO - 'sessionrestore_no_auto_restore', 02:05:33 INFO - 'tabpaint']}, 02:05:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['a11yr', 02:05:33 INFO - 'ts_paint', 02:05:33 INFO - 'tpaint', 02:05:33 INFO - 'sessionrestore', 02:05:33 INFO - 'sessionrestore_no_auto_restore', 02:05:33 INFO - 'tabpaint']}, 02:05:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['tsvgx', 02:05:33 INFO - 'tsvgr_opacity', 02:05:33 INFO - 'tart', 02:05:33 INFO - 'tscrollx', 02:05:33 INFO - 'cart']}, 02:05:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:05:33 INFO - 'tsvgr_opacity', 02:05:33 INFO - 'tart', 02:05:33 INFO - 'tscrollx', 02:05:33 INFO - 'cart']}, 02:05:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:33 INFO - 'talos_options': ['--disable-e10s'], 02:05:33 INFO - 'tests': ['tp5o']}, 02:05:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:33 INFO - 'tests': ['tp5o']}, 02:05:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:33 INFO - 'talos_options': ['--disable-e10s', 02:05:33 INFO - '--xperf_path', 02:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:33 INFO - 'tests': ['tp5n']}, 02:05:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:05:33 INFO - 'talos_options': ['--xperf_path', 02:05:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:05:33 INFO - 'tests': ['tp5n']}}, 02:05:33 INFO - 'talos.zip': {'path': '', 02:05:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:05:33 INFO - Running post-action listener: _resource_record_post_action 02:05:33 INFO - [mozharness: 2017-01-23 10:05:33.748562Z] Finished populate-webroot step (success) 02:05:33 INFO - [mozharness: 2017-01-23 10:05:33.748697Z] Running create-virtualenv step. 02:05:33 INFO - Running pre-action listener: _resource_record_pre_action 02:05:33 INFO - Running main action method: create_virtualenv 02:05:33 INFO - Creating virtualenv /builds/slave/test/build/venv 02:05: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 02:05:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:05:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:05:33 INFO - Using real prefix '/tools/python27' 02:05:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:05:34 INFO - Installing distribute.............................................................................................................................................................................................done. 02:05:37 INFO - Installing pip.................done. 02:05:37 INFO - Return code: 0 02:05:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 02:05:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 02:05:37 INFO - Reading from file tmpfile_stdout 02:05:37 INFO - Output received: 02:05:37 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 02:05:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:05: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')]} 02:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05: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')]} 02:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05: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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:05: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 02:05: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 02:05:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:05:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:37 INFO - 'HOME': '/Users/cltbld', 02:05:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:37 INFO - 'LOGNAME': 'cltbld', 02:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:37 INFO - 'MOZ_NO_REMOTE': '1', 02:05:37 INFO - 'NO_EM_RESTART': '1', 02:05:37 INFO - 'PAGER': '/bin/cat', 02:05:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:37 INFO - 'PWD': '/builds/slave/test', 02:05:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:37 INFO - 'SHELL': '/bin/bash', 02:05:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:05:37 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:05:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:37 INFO - 'USER': 'cltbld', 02:05:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:37 INFO - 'XPC_FLAGS': '0x0', 02:05:37 INFO - 'XPC_SERVICE_NAME': '0', 02:05:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05: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 02:05:37 INFO - Cleaning up... 02:05:37 INFO - Return code: 0 02:05:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:05: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')]} 02:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:38 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')]} 02:05:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:38 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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:05:38 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 02:05:38 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 02:05:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:05:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:38 INFO - 'HOME': '/Users/cltbld', 02:05:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:38 INFO - 'LOGNAME': 'cltbld', 02:05:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:38 INFO - 'MOZ_NO_REMOTE': '1', 02:05:38 INFO - 'NO_EM_RESTART': '1', 02:05:38 INFO - 'PAGER': '/bin/cat', 02:05:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:38 INFO - 'PWD': '/builds/slave/test', 02:05:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:38 INFO - 'SHELL': '/bin/bash', 02:05:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:05:38 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:05:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:38 INFO - 'USER': 'cltbld', 02:05:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:38 INFO - 'XPC_FLAGS': '0x0', 02:05:38 INFO - 'XPC_SERVICE_NAME': '0', 02:05:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:38 INFO - Downloading/unpacking psutil>=3.1.1 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:05:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:42 INFO - Installing collected packages: psutil 02:05:42 INFO - Running setup.py install for psutil 02:05:42 INFO - building 'psutil._psutil_osx' extension 02:05: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 02:05: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 02:05: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 02:05: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 02:05:42 INFO - building 'psutil._psutil_posix' extension 02:05: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 02:05:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:05:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:05:42 INFO - ^ 02:05:42 INFO - 1 warning generated. 02:05:42 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 02:05:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:05:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:05:43 INFO - Successfully installed psutil 02:05:43 INFO - Cleaning up... 02:05:43 INFO - Return code: 0 02:05:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:05: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')]} 02:05:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05: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')]} 02:05:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05: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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:05: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 02:05: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 02:05:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:05:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:43 INFO - 'HOME': '/Users/cltbld', 02:05:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:43 INFO - 'LOGNAME': 'cltbld', 02:05:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:43 INFO - 'MOZ_NO_REMOTE': '1', 02:05:43 INFO - 'NO_EM_RESTART': '1', 02:05:43 INFO - 'PAGER': '/bin/cat', 02:05:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:43 INFO - 'PWD': '/builds/slave/test', 02:05:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:43 INFO - 'SHELL': '/bin/bash', 02:05:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:05:43 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:05:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:43 INFO - 'USER': 'cltbld', 02:05:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:43 INFO - 'XPC_FLAGS': '0x0', 02:05:43 INFO - 'XPC_SERVICE_NAME': '0', 02:05:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:05:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:05:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:05:46 INFO - Installing collected packages: mozsystemmonitor 02:05:46 INFO - Running setup.py install for mozsystemmonitor 02:05:46 INFO - Successfully installed mozsystemmonitor 02:05:46 INFO - Cleaning up... 02:05:46 INFO - Return code: 0 02:05:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:05: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')]} 02:05:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05: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')]} 02:05:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05: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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:05: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 02:05: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 02:05:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:05:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:46 INFO - 'HOME': '/Users/cltbld', 02:05:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:46 INFO - 'LOGNAME': 'cltbld', 02:05:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:46 INFO - 'MOZ_NO_REMOTE': '1', 02:05:46 INFO - 'NO_EM_RESTART': '1', 02:05:46 INFO - 'PAGER': '/bin/cat', 02:05:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:46 INFO - 'PWD': '/builds/slave/test', 02:05:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:46 INFO - 'SHELL': '/bin/bash', 02:05:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:05:46 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:05:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:46 INFO - 'USER': 'cltbld', 02:05:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:46 INFO - 'XPC_FLAGS': '0x0', 02:05:46 INFO - 'XPC_SERVICE_NAME': '0', 02:05:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:46 INFO - Downloading/unpacking jsonschema==2.5.1 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:05:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:05:49 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 02:05:49 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 02:05:49 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 02:05:49 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 02:05:49 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 02:05:49 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 02:05:49 INFO - Downloading functools32-3.2.3-2.tar.gz 02:05:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:05:49 INFO - warning: no files found matching '*.txt' 02:05:49 INFO - no previously-included directories found matching 'build' 02:05:49 INFO - no previously-included directories found matching 'dist' 02:05:49 INFO - no previously-included directories found matching '.git*' 02:05:49 INFO - Installing collected packages: jsonschema, functools32 02:05:49 INFO - Running setup.py install for functools32 02:05:49 INFO - warning: no files found matching '*.txt' 02:05:49 INFO - no previously-included directories found matching 'build' 02:05:49 INFO - no previously-included directories found matching 'dist' 02:05:49 INFO - no previously-included directories found matching '.git*' 02:05:49 INFO - Successfully installed jsonschema functools32 02:05:49 INFO - Cleaning up... 02:05:49 INFO - Return code: 0 02:05:49 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 02:05: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')]} 02:05:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05: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')]} 02:05:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05: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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:05: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 02:05: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 02:05:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:05:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:49 INFO - 'HOME': '/Users/cltbld', 02:05:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:49 INFO - 'LOGNAME': 'cltbld', 02:05:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:49 INFO - 'MOZ_NO_REMOTE': '1', 02:05:49 INFO - 'NO_EM_RESTART': '1', 02:05:49 INFO - 'PAGER': '/bin/cat', 02:05:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:49 INFO - 'PWD': '/builds/slave/test', 02:05:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:49 INFO - 'SHELL': '/bin/bash', 02:05:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:05:49 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:05:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:49 INFO - 'USER': 'cltbld', 02:05:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:49 INFO - 'XPC_FLAGS': '0x0', 02:05:49 INFO - 'XPC_SERVICE_NAME': '0', 02:05:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 02:05:50 INFO - Cleaning up... 02:05:50 INFO - Return code: 0 02:05:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:05:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:05:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:05:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:05:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:50 INFO - 'HOME': '/Users/cltbld', 02:05:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:50 INFO - 'LOGNAME': 'cltbld', 02:05:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:50 INFO - 'MOZ_NO_REMOTE': '1', 02:05:50 INFO - 'NO_EM_RESTART': '1', 02:05:50 INFO - 'PAGER': '/bin/cat', 02:05:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:50 INFO - 'PWD': '/builds/slave/test', 02:05:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:50 INFO - 'SHELL': '/bin/bash', 02:05:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:05:50 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:05:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:50 INFO - 'USER': 'cltbld', 02:05:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:50 INFO - 'XPC_FLAGS': '0x0', 02:05:50 INFO - 'XPC_SERVICE_NAME': '0', 02:05:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:50 INFO - Downloading/unpacking blobuploader==1.2.4 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05:53 INFO - Downloading blobuploader-1.2.4.tar.gz 02:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:05:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:05:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05: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 02:05:54 INFO - Downloading docopt-0.6.1.tar.gz 02:05:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:05:54 INFO - Installing collected packages: blobuploader, requests, docopt 02:05:54 INFO - Running setup.py install for blobuploader 02:05:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:05:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:05:54 INFO - Running setup.py install for requests 02:05:55 INFO - Running setup.py install for docopt 02:05:55 INFO - Successfully installed blobuploader requests docopt 02:05:55 INFO - Cleaning up... 02:05:55 INFO - Return code: 0 02:05:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:05:55 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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:05:55 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 02:05:55 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 02:05:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:05:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:05:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:05:55 INFO - 'HOME': '/Users/cltbld', 02:05:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:05:55 INFO - 'LOGNAME': 'cltbld', 02:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:05:55 INFO - 'MOZ_NO_REMOTE': '1', 02:05:55 INFO - 'NO_EM_RESTART': '1', 02:05:55 INFO - 'PAGER': '/bin/cat', 02:05:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:05:55 INFO - 'PWD': '/builds/slave/test', 02:05:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:05:55 INFO - 'SHELL': '/bin/bash', 02:05:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:05:55 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:05:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:05:55 INFO - 'USER': 'cltbld', 02:05:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:05:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:05:55 INFO - 'XPC_FLAGS': '0x0', 02:05:55 INFO - 'XPC_SERVICE_NAME': '0', 02:05:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:05:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:05:55 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-5yF1k5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:05:55 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-reIJaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:05:55 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-SsAb3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:05:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:05:55 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ok6yeL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:05:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-hQyU6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:05:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-INAZo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:05:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-4TRPVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:05:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-cBxl9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:05:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-gc5eUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:05:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-kWRXUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:05:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-8sv4yG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:05:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-aujlos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:05:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:05:56 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-UvIQxD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:05:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-uOEl9i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-3Me_98-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:05:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ALRudK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:05:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:05:57 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-NxYtUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:05:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:05:57 INFO - Running setup.py install for manifestparser 02:05:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:05:57 INFO - Running setup.py install for mozcrash 02:05:57 INFO - Running setup.py install for mozdebug 02:05:57 INFO - Running setup.py install for mozdevice 02:05:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:05:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:05:58 INFO - Running setup.py install for mozfile 02:05:58 INFO - Running setup.py install for mozhttpd 02:05:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:05:58 INFO - Running setup.py install for mozinfo 02:05:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:05:58 INFO - Running setup.py install for mozInstall 02:05:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:05:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:05:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:05:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:05:58 INFO - Running setup.py install for mozleak 02:05:58 INFO - Running setup.py install for mozlog 02:05:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:05:58 INFO - Running setup.py install for moznetwork 02:05:59 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:05:59 INFO - Running setup.py install for mozprocess 02:05:59 INFO - Running setup.py install for mozprofile 02:05:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:05:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:05:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:05:59 INFO - Running setup.py install for mozrunner 02:05:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:05:59 INFO - Running setup.py install for mozscreenshot 02:05:59 INFO - Running setup.py install for moztest 02:05:59 INFO - Running setup.py install for mozversion 02:05:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:06:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:06:00 INFO - Cleaning up... 02:06:00 INFO - Return code: 0 02:06:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 02:06:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:00 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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:06:00 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 02:06:00 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 02:06:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:06:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:00 INFO - 'HOME': '/Users/cltbld', 02:06:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:00 INFO - 'LOGNAME': 'cltbld', 02:06:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:00 INFO - 'MOZ_NO_REMOTE': '1', 02:06:00 INFO - 'NO_EM_RESTART': '1', 02:06:00 INFO - 'PAGER': '/bin/cat', 02:06:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:00 INFO - 'PWD': '/builds/slave/test', 02:06:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:00 INFO - 'SHELL': '/bin/bash', 02:06:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:06:00 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:06:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:00 INFO - 'USER': 'cltbld', 02:06:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:00 INFO - 'XPC_FLAGS': '0x0', 02:06:00 INFO - 'XPC_SERVICE_NAME': '0', 02:06:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:06:00 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-hD8ORR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:06:00 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)) 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:06:00 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-14zX81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:06:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:06:00 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-xPcfLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:06: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)) 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:06:00 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-KosHnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:06: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)) 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:06:00 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-uZ_CFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:06: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)) 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:06:00 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-rp6pKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:06: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)) 02:06:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:06:00 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-aL_cNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:06:01 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)) 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:06:01 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-_Q7Pmp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:06:01 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)) 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:06:01 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-sHl2xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:06:01 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)) 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:06:01 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-X_SIXQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:06:01 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)) 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:06:01 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-OlvCjb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:06:01 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)) 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:06:01 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-uO3jIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:06:01 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)) 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:06:01 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-48hqs6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:06: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)) 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:06:01 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-5opz9t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:06:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:06:01 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-uoAqts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:06: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)) 02:06:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:06:01 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-i2NRZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:06:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:06:02 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-0Kpt5W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:06:02 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)) 02:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:06:02 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)) 02:06:02 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)) 02:06:02 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)) 02:06:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:06:04 INFO - Downloading blessings-1.6.tar.gz 02:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:06:04 INFO - Installing collected packages: blessings 02:06:04 INFO - Running setup.py install for blessings 02:06:04 INFO - Successfully installed blessings 02:06:04 INFO - Cleaning up... 02:06:05 INFO - Return code: 0 02:06:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:05 INFO - Reading from file tmpfile_stdout 02:06:05 INFO - Current package versions: 02:06:05 INFO - blessings == 1.6 02:06:05 INFO - blobuploader == 1.2.4 02:06:05 INFO - docopt == 0.6.1 02:06:05 INFO - functools32 == 3.2.3-2 02:06:05 INFO - jsonschema == 2.5.1 02:06:05 INFO - manifestparser == 1.1 02:06:05 INFO - mozInstall == 1.12 02:06:05 INFO - mozcrash == 1.0 02:06:05 INFO - mozdebug == 0.1 02:06:05 INFO - mozdevice == 0.48 02:06:05 INFO - mozfile == 1.2 02:06:05 INFO - mozhttpd == 0.7 02:06:05 INFO - mozinfo == 0.9 02:06:05 INFO - mozleak == 0.1 02:06:05 INFO - mozlog == 3.4 02:06:05 INFO - moznetwork == 0.27 02:06:05 INFO - mozprocess == 0.23 02:06:05 INFO - mozprofile == 0.28 02:06:05 INFO - mozrunner == 6.13 02:06:05 INFO - mozscreenshot == 0.1 02:06:05 INFO - mozsystemmonitor == 0.3 02:06:05 INFO - moztest == 0.8 02:06:05 INFO - mozversion == 1.4 02:06:05 INFO - psutil == 3.1.1 02:06:05 INFO - requests == 1.2.3 02:06:05 INFO - wsgiref == 0.1.2 02:06:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:06:05 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')]} 02:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:05 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')]} 02:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:05 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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:06:05 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 02:06:05 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 02:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:05 INFO - 'HOME': '/Users/cltbld', 02:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:05 INFO - 'LOGNAME': 'cltbld', 02:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:05 INFO - 'MOZ_NO_REMOTE': '1', 02:06:05 INFO - 'NO_EM_RESTART': '1', 02:06:05 INFO - 'PAGER': '/bin/cat', 02:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:05 INFO - 'PWD': '/builds/slave/test', 02:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:05 INFO - 'SHELL': '/bin/bash', 02:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:06:05 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:05 INFO - 'USER': 'cltbld', 02:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:05 INFO - 'XPC_FLAGS': '0x0', 02:06:05 INFO - 'XPC_SERVICE_NAME': '0', 02:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:05 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)) 02:06:05 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)) 02:06:05 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)) 02:06:05 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)) 02:06:05 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)) 02:06:05 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)) 02:06:05 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)) 02:06:05 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)) 02:06:05 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)) 02:06:05 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)) 02:06:05 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)) 02:06:05 INFO - Cleaning up... 02:06:05 INFO - Return code: 0 02:06:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:06:05 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')]} 02:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:05 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')]} 02:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:06:05 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 0x10b957490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8cd570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa2b59c570>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, '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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 02:06:05 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 02:06:05 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 02:06:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:06:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:05 INFO - 'HOME': '/Users/cltbld', 02:06:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:05 INFO - 'LOGNAME': 'cltbld', 02:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:05 INFO - 'MOZ_NO_REMOTE': '1', 02:06:05 INFO - 'NO_EM_RESTART': '1', 02:06:05 INFO - 'PAGER': '/bin/cat', 02:06:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:05 INFO - 'PWD': '/builds/slave/test', 02:06:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:05 INFO - 'SHELL': '/bin/bash', 02:06:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:06:05 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:06:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:05 INFO - 'USER': 'cltbld', 02:06:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:05 INFO - 'XPC_FLAGS': '0x0', 02:06:05 INFO - 'XPC_SERVICE_NAME': '0', 02:06:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:06:05 INFO - Cleaning up... 02:06:05 INFO - Return code: 0 02:06:05 INFO - Running post-action listener: _resource_record_post_action 02:06:05 INFO - Running post-action listener: _start_resource_monitoring 02:06:05 INFO - Starting resource monitoring. 02:06:05 INFO - [mozharness: 2017-01-23 10:06:05.930064Z] Finished create-virtualenv step (success) 02:06:05 INFO - [mozharness: 2017-01-23 10:06:05.931030Z] Running install step. 02:06:05 INFO - Running pre-action listener: _resource_record_pre_action 02:06:05 INFO - Running main action method: install 02:06:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:06:06 INFO - Reading from file tmpfile_stdout 02:06:06 INFO - Detecting whether we're running mozinstall >=1.0... 02:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:06:06 INFO - Reading from file tmpfile_stdout 02:06:06 INFO - Output received: 02:06:06 INFO - Usage: mozinstall [options] installer 02:06:06 INFO - Options: 02:06:06 INFO - -h, --help show this help message and exit 02:06:06 INFO - -d DEST, --destination=DEST 02:06:06 INFO - Directory to install application into. [default: 02:06:06 INFO - "/builds/slave/test"] 02:06:06 INFO - --app=APP Application being installed. [default: firefox] 02:06:06 INFO - mkdir: /builds/slave/test/build/application 02:06:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 02:06:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 02:06:37 INFO - Reading from file tmpfile_stdout 02:06:37 INFO - Output received: 02:06:37 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 02:06:37 INFO - Running post-action listener: _resource_record_post_action 02:06:37 INFO - [mozharness: 2017-01-23 10:06:37.749092Z] Finished install step (success) 02:06:37 INFO - [mozharness: 2017-01-23 10:06:37.749251Z] Running run-tests step. 02:06:37 INFO - Running pre-action listener: _resource_record_pre_action 02:06:37 INFO - Running main action method: run_tests 02:06:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:06:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:06:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:06:37 INFO - 2017-01-23 02:06:37.763 screenresolution[1633:8372] starting screenresolution argv=screenresolution get 02:06:37 INFO - 2017-01-23 02:06:37.766 screenresolution[1633:8372] Display 0: 1600x1200x32@60 02:06:37 INFO - 2017-01-23 02:06:37.771 screenresolution[1634:8374] starting screenresolution argv=screenresolution list 02:06:37 INFO - Available Modes on Display 0 02:06:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:06:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:06:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:06:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:06:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:06:37 INFO - Intel Iris: 02:06:37 INFO - Chipset Model: Intel Iris 02:06:37 INFO - Type: GPU 02:06:37 INFO - Bus: Built-In 02:06:37 INFO - VRAM (Dynamic, Max): 1536 MB 02:06:37 INFO - Vendor: Intel (0x8086) 02:06:37 INFO - Device ID: 0x0a2e 02:06:37 INFO - Revision ID: 0x0009 02:06:37 INFO - Displays: 02:06:37 INFO - Display: 02:06:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:06:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:06:37 INFO - Display Serial Number: 1600x1200 60 02:06:38 INFO - Main Display: Yes 02:06:38 INFO - Mirror: Off 02:06:38 INFO - Online: Yes 02:06:38 INFO - Rotation: Supported 02:06:38 INFO - Return code: 0 02:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:06:38 INFO - Python 2.7.3 02:06:38 INFO - Return code: 0 02:06:38 INFO - grabbing minidump binary from tooltool 02:06:38 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')]} 02:06:38 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 0x10b76bd30>, '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 0x10b5d1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b763b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:06:38 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 02:06:38 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 02:06:38 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 02:06:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:06:38 INFO - Return code: 0 02:06:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:06:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:06:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:06:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:06:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:06:38 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/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 02:06:38 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/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0295 --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 02:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.2rSNmIjNpx/Render', 02:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:06:38 INFO - 'HOME': '/Users/cltbld', 02:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:06:38 INFO - 'LOGNAME': 'cltbld', 02:06:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:06:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:06:38 INFO - 'MOZ_NO_REMOTE': '1', 02:06:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:06:38 INFO - 'NO_EM_RESTART': '1', 02:06:38 INFO - 'PAGER': '/bin/cat', 02:06:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:06:38 INFO - 'PWD': '/builds/slave/test', 02:06:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:06:38 INFO - 'SHELL': '/bin/bash', 02:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6aqN1XhNiO/Listeners', 02:06:38 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 02:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:06:38 INFO - 'USER': 'cltbld', 02:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:06:38 INFO - 'XPC_FLAGS': '0x0', 02:06:38 INFO - 'XPC_SERVICE_NAME': '0', 02:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:06:38 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/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 02:06:38 INFO - mozversion application_buildid: 20170123004004 02:06:38 INFO - mozversion application_changeset: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 02:06:38 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:06:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:06:38 INFO - mozversion application_name: Firefox 02:06:38 INFO - mozversion application_remotingname: firefox-dev 02:06:38 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:06:38 INFO - mozversion application_vendor: Mozilla 02:06:38 INFO - mozversion application_version: 52.0a2 02:06:38 INFO - mozversion platform_buildid: 20170123004004 02:06:38 INFO - mozversion platform_changeset: 24a81d93e07cc96300f8e1f5c69034dd4743bd63 02:06:38 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:06:38 INFO - mozversion platform_version: 52.0a2 02:06:38 INFO - using testdate: 1485165998 02:06:38 INFO - actual date: 1485165998 02:06:38 INFO - starting webserver on 'localhost:49240' 02:06:38 INFO - SUITE-START | Running 2 tests 02:06:38 INFO - TEST-START | dromaeo_css 02:06:38 INFO - operating with platform_type : mac_ 02:06:38 INFO - Initialising browser for dromaeo_css test... 02:06:38 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmplqL_ck/profile http://localhost:49240/getInfo.html) 02:06:41 INFO - PROCESS | 1644 | __metrics Screen width/height:1600/1200 02:06:41 INFO - PROCESS | 1644 | colorDepth:24 02:06:41 INFO - PROCESS | 1644 | Browser inner width/height: 1024/689 02:06:41 INFO - PROCESS | 1644 | __metrics 02:06:41 INFO - PROCESS | 1644 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:06:41 INFO - PROCESS | 1644 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:06:42 INFO - TEST-INFO | 1644: exit 0 02:06:42 INFO - Browser initialized. 02:06:42 INFO - Running cycle 1/1 for dromaeo_css test... 02:06:42 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmplqL_ck/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:06:54 INFO - PROCESS | 1648 | RSS: Main: 222232576 02:06:54 INFO - PROCESS | 1648 | 02:09:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 02:09:59 INFO - PROCESS | 1648 | RSS: Main: 347820032 02:09:59 INFO - PROCESS | 1648 | 02:13:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 02:13:03 INFO - PROCESS | 1648 | RSS: Main: 348418048 02:13:03 INFO - PROCESS | 1648 | 02:16:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 02:16:06 INFO - PROCESS | 1648 | RSS: Main: 325890048 02:16:06 INFO - PROCESS | 1648 | 02:19:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 02:19:09 INFO - PROCESS | 1648 | RSS: Main: 317259776 02:19:09 INFO - PROCESS | 1648 | 02:22:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 02:22:13 INFO - PROCESS | 1648 | RSS: Main: 307044352 02:22:13 INFO - PROCESS | 1648 | 02:25:16 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 02:25:17 INFO - PROCESS | 1648 | RSS: Main: 379437056 02:25:17 INFO - PROCESS | 1648 | 02:25:17 INFO - PROCESS | 1648 | __start_tp_report 02:25:17 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 02:25:17 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 02:25:17 INFO - PROCESS | 1648 | |i|pagename|runs| 02:25:17 INFO - PROCESS | 1648 | |0;dojo.html;3319.3195394944037;3335.7164641005515;3350.8492117854694;3382.222088919547;3420.8631654733813;5668.376478587357;5682.488576028157;5738.971305143479;5751.942480575198;5793.507551858092;5696.658200507973;5783.190353350535;5784.913226301609;5799.391063938278;5802.680852553108;5251.212318152279;5277.340332458442;5298.761555729982;5302.257683924235;5322.547583455411;5199.68801871887;5207.583393328525;5359;5366.4633536646415;5377.946220537784;5187.066328060948;5241.947580524203;5262.60530460217;5324.41431442541;5333;5256.159014557691;5256.842294731164;5271.894562108775;5273.129933560957;5281.260623512692;5213.661112027706;5281.63028587999;5299.867503312409;5300.337457817773;5301.151815709468;4804.375431193957;5499.587530935196;5613.101903695389;5769.740361683735;5867.530597552186;6087.117367981662;6119.756006473298;6138.140660307516;6147.2930612979635;6174.44430001302;6177.1260296868395;6210.65841378724;6255;6289.7169627366875;6294.433500984887;5630.5214056805635;5741.799037033684;5765.250517432707;5770.451807078321;5799.420057994167;6229.53278504114;6253.593516421418;6259.624422534663;6279.089532017923;6286.308506064329;6169.413905678954;6182.505399568024;6184.196054512884;6186.783462578878;6196.225471816023;6102.328743838174;6291.056341548804;6319.905201421982;6323.30443651198;6330.746770129143;6103.511719062464;6125.958587040125;6138.13807813537;6152.415520525543;6156.78451254204;6141.723622437001;6163.229596300463;6169.537284703665;6195.729875375538;6224.906626400608;4268.59448352406;4289.356596510486;4924.75376231187;4940.135476291706;4966.428860681068;4435.534268901783;4445.222086134913;4448.955510444919;4478.932816007762;4490.708103973297;5602.915956260659;5664.631798933056;5680.573956953245;5830.3586605473365;5846.181534585162;6152.538559608047;6261.436470717657;6283.7800676977;6326.936730632727;6344.524160687967;5780.624259423124;5790.652560846363;5801.564882633819;5845.853853653608;5862.882742345129;4813.278008298783;5290.65610735301;5410.053240682865;5433.8369848904595;5446.264754258124;5368.812091576776;6197.845053873689;6224.564280500503;6243.250809902841;6244.812655620339;6276.968615156895;6293.937060629335;6300.464460520907;6300.684965751602;6315.652639104894;6090.908636370546;6242.625442473466;6279.96860015697;6303.117563541016;6307.274663413767;6047.637141771508;6087.969560152171;6129.264488261437;6130.7038937848565;6255.78104766331;6255.9374406257175;6299.559030867796;6301.905471418024;6306.779262725782;6312.747490100344;6157.415045570664;6161.907571386343;6170.259568851587;6170.321264660974;6184.81445556634;5859.296884373903;5887;5907.4683278505145;6086.087086936995;6182.010878259637;5944.732487038007;6046.032634778414;6058.303295121117;6071.423214794588;6105.389461053859;6184.103305020837;6192.947198976275;6194;6195.1636529068;6200.162977997912;5797;5820.796272130455;5921;6059.606125601822;6092.8781424372155 02:25:17 INFO - PROCESS | 1648 | |1;ext.html;494.5005544400156;497.19950879084666;522.5375542644758;527.564759073764;546.6747285365211;30288.394232115344;30739.538906916387;39510.209795804105;40879.59120408795;40895.38656920149;42289.36565951513;42696.57303426965;42722.572774272245;42782;42925.92685182872;9187.816243675123;9324.813503729922;9350.438973661569;9353.15821576058;9362.531873406337;9323.813523729521;9443.95278023609;9444.291678124135;9448.24414046878;9453.385529940531;9292.117248861347;9375.578098985528;9424.293178011641;9453.669121580746;9491.572879220417;9395.201407880339;9452.338336316461;9462.810743785154;9463.290253230967;9479.241660667165;9289.814203715956;9360.391574547633;9370.390924589949;9373.53132343387;9378.577963991636;39392.81821545358;39587.01032474182;39671.60328396737;39713.20573588541;39797.20405591872;3187.7609179311644;3230.305484320859;3269.1663625775277;3275.557799697034;3782.3569993101237;28911.277218069506;29946.25134371658;30147.547786783216;30582.541261881088;30892.073237802902;3124.0315502194394;3205.8877939272247;3219.983900080508;3221.7905836120576;3227.9677203227902;473872;474778;476044;476236.6188169106;489179;60377.39622603806;60776;60797.78404431887;60881.391186088455;60922.08616870751;34563.30873382569;35324.82337588296;35400.58397664064;36374.09064773402;64074.6796266025;15826.208689565476;15976.121313327878;15984.76022859658;15998.360065597479;16007.59981000461;12104.576339828063;12205.20666156697;12219.450124744408;12248.44881980313;12253.754924901452;18928.905355473136;19011.429657110308;19013.524661883563;19042.904785475985;19070.33253836109;7379.520331178456;7483.32650061497;7487.801951687813;7573.886391704129;7593;833.7123692326138;916.2074805293373;960.8798900137483;980.4803454169302;1049.150188347441;28742;29399.559006614916;29430;30189.547156792665;30401.543976840367;896.7175339767953;930.6044930904474;985.4924713772413;1015.4567306490992;1043.6190790361616;12764.170328928776;15070.773938390932;15399.23003849803;15511.689766204838;16297.755533667005;662970;663639;664653;665040;665492;58568.70715646395;59165.704171478865;59167.70416147978;59260.111098332694;59291;1144.6623246142242;1168.2056201782868;1220.7436438347868;1285.4215602978697;1362.1350442469104;28644.14067577976;30353.544696829125;30503.084907452812;30734.077977660705;31027.68972310248;50098.49901500938;50800.23799642934;50854.982900342526;50916.49083509117;51110.23334649909;536762;541522;541754;542126;542806;23875;26347.868260658575;27024;27348.589771153052;27536.311592210353;45096.54903450923;45575.088498230514;45732.542674572825;46437.53562464332;46692.832679183295;38181.61818381781;38868.028299292746;39566.40650390189;39904;40312.59687403088;35993;40180.598194017686;40297.395539066354;41645.58354416417;41790.582094178666;37752.62247377491;37867.431988519646;38137;38736.41895371628;38964;32231.35537289288;34069.829650851585;34191.4871276936;34790.82604586961;34838;22726.431839204153;24089;25552.744472555038;25655.871720641277;25712 02:25:17 INFO - PROCESS | 1648 | |2;jquery.html;349.1707195410899;366.8770961727821;374.2160174434559;379.16772683958703;402.3200790663778;14832.813374930007;15109.09345439273;15888.566199872685;20197.999999999964;20606.690899636516;18934.90532547335;19353.03234838256;20020.699689504632;20200.484963627714;20448.07983640736;5766.942330576693;6016.699165041752;6016.7665628546265;6017.548683848707;6022.939770602282;5139.357580302462;6522.4129828315445;6610.8016759497295;6652.101966234569;6691.36432038958;5077.59379249661;5701.859628074381;6589.472842172639;6601.768938087168;6652.434543063845;6017.308009578889;6036.788712395045;6037.667928263943;6043.607165534227;6044.214252147192;5674.744636491368;5840.591158618899;5892.410758924116;5951.256092988377;5955.940440595582;13004.959603231813;13117.60647180586;13446.462141514328;21214;24983.62524562133;2526.7852232560253;2576.8453892766493;2637.7494138056854;2807.1297897651793;2909.301767575788;10051.396916185053;10174.931632178663;10386;11642.59250926222;15551.611209719735;1610.9597260068592;1853.5829438376256;1856.1090676475367;1860.4325680667391;1866.915988780508;124376;129027;130675;131251.3437432816;135431.64568354288;9318;9911.900880991241;9915.256355773347;10026.348287361445;10576.365418074785;10286.177105831515;12461.252324860538;12463.065270104778;12464.81302780459;12470;7798.259165379393;7999.840003199904;8036.598170091472;8093.878591821127;8153.6738530458115;8344.457610255435;8347.332213423033;8468.957655211685;8532.957335213285;8534.573271336409;3826.1199924017633;3851.287511810324;3916.3146449371247;3944.5069366329208;4003.619656132663;1673.8326167383163;1886.7735871695484;1910.436421255733;1922.7692676878864;1942.9708554371696;801.3068695578282;806.4072906413782;833.7457075591882;855.3713020929612;916.6974898283551;19784.50538736514;20863;21016.94915254231;21060.684089738665;21104.577908442054;813.8982627171604;902.4991129922824;905.7282815155427;925.9305552083486;982.5529384130203;9485.288603354777;10476.371417714809;10845.13238940883;10914.617988370368;10992.120630349553;590564;596305;603404;603535;604856;94549;105132;105450;111566.88433115727;134221.32889335492;844.2148801614558;889.3729920406228;946.2855544064325;950.135376807116;955.6416343871049;18767.53081172927;19288;19565.902170489055;19592.412227633195;19704.80295197087;54919.901601966936;56507.71746141243;57395;57668.423315766304;58649.5337616563;73591;76414;77788;78413;81133;7908.248716371935;8024.679012839654;8062.798430039296;8170.264676179172;8244.505329680238;10331.586736530455;12317.753644926872;12483.93758031204;12904.548340808027;13014.15407998477;8947.373683842328;10881.075108615856;11068.833967490655;11086.334819910831;11341.943290283496;10667.359958402521;10940.726481838017;10965.890341096487;11009.449527523751;11016.724581885197;11153.330800152016;11259.493322800658;11265.718357040812;11315.886841131483;11443.313401195956;7906.802329941797;7932.841343172989;8073.071596766447;8106.716264930699;8143.918560814316;8871.733847984571;10899.78200435971;11075.778484430106;11206.99137077667;11294.926981936704 02:25:17 INFO - PROCESS | 1648 | |3;mootools.html;1154.295879513497;1361.8570050144733;1462.963425914352;1543.236098131425;1695.762593236947;7428.6657100430475;7810;8159.714409995651;8483.236508714215;8501.702440414587;8329.292010179142;8408.537530435824;8432.198941100585;8440.113788052258;8440.240378365961;2320.918767843126;2347.1315613223046;2350.0247397330086;2350.247920665388;2353.752855950126;2341.5433990371885;2377.263048454976;2386.95226095478;2387.6299173628117;2389.223502361731;2323.9883800581056;2338.3452633262627;2358.6697862299293;2362.196853069956;2367.2543148908126;1960.3334866145508;2283.897224624896;2288.302067869299;2333.556624241389;2337.742848286687;2338.8128949683983;2359.457324815285;2360.9409764755846;2365.136725095345;2365.716114066323;8331.12523185069;8406.117357677416;8422.24199822019;8442.831143377098;8447.831043379098;4990.700557966497;5017.422996355429;5191.480851914778;5191.896162076775;5201.24581935621;3250.089974807034;3331.6501767314326;3367.7810942288916;3438.209211881256;3449.6032956209856;1005.4369553050242;1036.6682661548307;1046.4976811130623;1063.4310643805604;1082.0586090101583;10796.028357447789;10840.349579025284;10944.4527773611;10952.452377381178;10959;4277.144571085733;4395.7362558246605;4493.573110554492;4493.88765280864;4524.5701658342405;8724.171203735761;8730.563471826383;8737.169968852948;8743.169398907094;8744.825103497895;5099.031184075014;5099.69401835891;5108.003939231814;5119.232115182753;5120.334356533627;3765.6799172070682;4222.59885310895;4380.364847097153;4646.697964632355;4774.236122220428;3652.5251717276583;3704.7962362070343;3711.4247291669835;3762.172322089136;3763.2124740748473;1139.7549526851767;1141.960031398897;1144.605111236622;1149.8735139134687;1152.3949926288599;785.9607019648995;804.159653162435;884.8318819424288;888.0852721696663;925.3106435705308;5557.972210139004;5658.066419040812;5839.941600584025;5900.763969441175;5949.791757288474;810.720301495983;869.4133206897311;918.4718786697542;922.7370199493113;931.3713243560705;3756.549214094326;3807.200487897517;3841.0781412461365;3923.9993801580986;3961.1087505311075;8719.476831390137;9885.406875587487;10158.847617285746;10273.332233404954;10284.691459256233;10226.897731022744;10230.02814732614;10247.795044099077;10248;10250.692479225636;7805.609719514002;7979.3616510679;7990.3208227300165;7992;7995.200479951958;5383.838484845461;5552.972235138798;5598;5775.133729940542;5799.5070419014855;9518.857217141887;9545.47499887485;9546.284028697737;9549.283803714889;9566.182425339164;8734.388592798443;9204.677836275967;9537.284703647116;9562.091601297865;9777.217822574035;6279.183706118175;6369.299377068612;6841.555298905754;6871.793846184622;6942.201646810479;8027.2775450209765;8039.598020099089;8067.354611631173;8144.429889907649;8145.918540814516;7230.023946767119;7273.454490913308;7282.45381596393;7289.744858929912;7326.413886889142;6773.356531129535;6931.514793964576;7030.859382812213;7106.609136497335;7186.7125314986815;6723.495737819585;6752.459803215829;6839.2818754032105;6842.315768423118;6843.281455447305;4789.784459699392;4794.472608013186;4940.802367905244;4959.454460009469;5093.0577843099145;4926.950730492649;4942.703437793743;5008.924866127084;5012.022655582126;5012.649114561946 02:25:17 INFO - PROCESS | 1648 | |4;prototype.html;298.42404159971255;299.99100026999173;307.6999925073054;313.1810316023598;314.83471177631725;4745.715257084573;4872.293517439969;5023.8492845214705;5151.304573882525;5262.4478477028;4857.198562237227;4963.3547638806995;5070.366204224472;5071.74641267936;5201.5955691963145;3580.4808302796077;3966.305896468121;3966.504186976628;3994.4607477990535;3996.38146550646;3738.738288319819;3942.211557688474;3985.7807820569856;3994.8002599870038;4000.999500249875;3406.42090844557;3741.494898188737;3969.7618142911374;3970.1067259866445;3988.082740969579;3778.0554861284677;3854.5952674969003;3927.293087244295;3947.842086316544;3949.861754838567;3167.8732850685947;3461.35585596842;3468.739844511672;3477.426224672926;3480.860765569374;4962.702237865739;5012.122878496249;5030.522100400456;5032.899342013139;5060.721660308682;3615.493830863681;4247.555831017469;4525.411696479469;4530.278494172194;4542.727436353829;4536.432945881765;4588.839390621312;5231.633785635007;5412.833492406947;5432.239486471897;3434.8797792077157;3658.6462110089174;3827.559830619459;3848.172642881766;3857.729958902878;4762.64280178988;5603.523700485463;5615.831525054255;5710.314762228476;5782.595218334718;3417.470292104728;3418.384690755638;3878.650921417086;3889.669378102893;3890.6498415142205;3904.29092362257;3915.197384536163;3938.936487148454;3951.8419263229725;3968.503937007874;4372.650187984954;4439.334099884978;4509.842155524541;4534.229181039165;4554.772261386917;4728.966544385947;5387.676739395649;5410.458954104558;5419.783208671609;5476.67139971603;1258.5657948007922;1273.5924504158766;1276.6297773645724;1291.9095663303667;1295.5854126679371;734.4858598980735;819.2012787532109;839.6221700234919;867.9392442529089;893.7497500699815;4311.741295522279;4422.823087076481;4518.81924723014;4613.423322084739;4635.907281854344;5306.230596563477;5326.840194794085;5332.6000549958135;5340;5371.57027437804;4431.822727090945;4508.774561271924;4557.225271703818;4593;4859.7327147006545;2349.8355115141776;2543.8982440702534;2651.482960822621;2715.6198132261497;2732.2486316263185;4820.6020254126615;5108.361454818148;5332.3867755207875;5484.7531861066345;5519.254900588449;4290.435633480779;4827.472543937172;5308.814191503279;5379.6234263601955;5452.427495113036;4490.910181796411;4903.730294833818;4972.0801651694555;5441.26542916717;5496.890062198733;4882.60939124862;5264.657797243321;5295.814646487509;5306.628536002443;5314.760835762323;4312.719673221231;4781.832635857728;4901.558859702502;5125.79332468643;5255.159174532057;4937.975310123426;5018.774155162953;5325.307709997675;5366.329208848894;5419.891602167856;3684.281565094781;3701.574318953355;3702.7593206441493;3703.6481534254203;3712.8329225184393;4490.618297444623;4926.433460152129;5085.64400491962;5173.1464308388695;5324.334458192726;4402.493713223021;4491.640668746558;4909.9558273870425;5141.38303403594;5152.896942061213;4322.78386080701;5149.459306772885;5155.9742201288755;5168.984096202409;5178.275041494118;4619.260918253198;4666.556677115668;4966.6771659842;4992.775325110451;5069.721165335942;4898.338724272177;4983.127952608206;5213.142274716758;5292.380271765501;5504.4495550444635;5053.509214781575;5349.438308977501;5363.356397232357;5365.704886231295;5381.770937437506 02:25:17 INFO - PROCESS | 1648 | |5;yui.html;675.2707076357534;702.8172675104473;739.8150462384403;741.2809574712527;775.5308038636626;13248.205107693546;13943.721125577482;13944.163350198982;13946.302684865766;13969.930150349246;12602.684932876682;12606.873931260685;12636.989040876731;12678.80981785274;12689.619311420649;659.8647277308164;677.6882633988371;804.8712206047034;814.722994181978;836.8870202522672;802.3821657323887;820.1388542030874;821.9835603287961;824.9257566818985;833.8248967716787;877.1316396767187;879.9560021998907;881.1540920716088;883.6156272021659;886.5522910929972;683.9350261725178;710.0201721624177;874.5889431966965;876.7676565710092;877.846376884046;630.8359826445111;648.45205801098;649.772579597142;650.7266947881901;651.7230177174729;13196.274204918725;13196.86803131966;13224.338783060808;13232.933835330858;13253.536126235633;12108.878911210862;12235.143539952207;12337.814932776015;12372.257664540157;12600;11345.829812552818;11511.942440287745;11605.4197290136;11703.824442633368;11799.46902389386;4168.478940132483;4218.2196293685765;4300.978495107504;4301.720388174758;4303.225419424502;82848.58575707143;85573.57213213894;85680.57159714223;85695.5715221426;86630;9411.90588094124;9634.951825240969;9823.508824558743;9980.500974951223;10244.948775256076;18424.81575184258;18480.168392422103;18535.53661158455;18551;18792.81207187938;7175.605341706152;7267.818304542323;7281.089863767029;7290.9635451822405;7440.181580026193;4028.436018957348;4053.331200351909;4102.876913692534;4144.730592511477;4299.183155200564;3126.765492588065;3174.7618928579986;3220.5974253218346;3220.951685724716;3222.8388580570877;574.4829653312053;584.4535359438938;591.961522501036;592.9288485381695;630.4735545819292;580.4891695308102;587.5769445998959;590.1737567405667;593.7773334999375;608.9025755879038;7578.166401695809;8015.238552337519;8576.828463430697;8636.654533818577;8644.91355086441;560.5727201218713;568.5394830187562;576.9423057694281;586.589387428793;587.6650309323644;4174.603412675791;4180.6412915801875;4196.244675958357;4232.068944832132;4278.336857787048;98824;109154.45422772835;112390.43804781088;115501;119747.40126299312;77189.21080918954;96546;107831;110828.44585777019;111349.88650113557;88758;89727;91214;91960.16079678369;92482;8085.757427277191;8118.431709780259;8144.086139757034;8223.465474744122;8317.376196785144;49081.75459122682;57732.13401798892;59683;60630.39369606424;61704.69147654233;83512.58243708986;83651.5817420909;86519.56740216259;87461.56269218613;88253.55873220593;10032.046955539212;10075.697729068139;10250.846237306298;10360.015798499131;10752.40861752611;11071;11558.653240402802;11822.054235661299;11978.820317695416;12158.696032598902;10877.021068103908;10907.236493445384;10992.28550144238;11019.889801102207;11349.886501134883;10891.292066015683;10956.890431095906;11000.559977600806;11144.60993865211;11474.655760327203;8785;9387.389819661701;10392.792144156923;10584.84122738175;11135;8428.410011299151;8579.14208579137;8666.220040196413;9028;9145.542722863696;8812.779680508038;8821.073787252246;8828.690995815115;8879.378443508893;8899.02110767828 02:25:17 INFO - PROCESS | 1648 | __end_tp_report 02:25:17 INFO - PROCESS | 1648 | __start_cc_report 02:25:17 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,1361 02:25:17 INFO - PROCESS | 1648 | __end_cc_report 02:25:17 INFO - PROCESS | 1648 | __startTimestamp1485167117007__endTimestamp 02:25:17 INFO - PROCESS | 1648 | 02:25:17 INFO - PROCESS | 1648 | ------- Summary: start ------- 02:25:17 INFO - PROCESS | 1648 | Number of tests: 6 02:25:17 INFO - PROCESS | 1648 | 02:25:17 INFO - PROCESS | 1648 | [#0] dojo.html Cycles:165 Average:5743.08 Median:5944.73 stddev:647.83 (10.9%) stddev-sans-first:621.29 02:25:17 INFO - PROCESS | 1648 | Values: 3319.3 3335.7 3350.8 3382.2 3420.9 5668.4 5682.5 5739.0 5751.9 5793.5 5696.7 5783.2 5784.9 5799.4 5802.7 5251.2 5277.3 5298.8 5302.3 5322.5 5199.7 5207.6 5359.0 5366.5 5377.9 5187.1 5241.9 5262.6 5324.4 5333.0 5256.2 5256.8 5271.9 5273.1 5281.3 5213.7 5281.6 5299.9 5300.3 5301.2 4804.4 5499.6 5613.1 5769.7 5867.5 6087.1 6119.8 6138.1 6147.3 6174.4 6177.1 6210.7 6255.0 6289.7 6294.4 5630.5 5741.8 5765.3 5770.5 5799.4 6229.5 6253.6 6259.6 6279.1 6286.3 6169.4 6182.5 6184.2 6186.8 6196.2 6102.3 6291.1 6319.9 6323.3 6330.7 6103.5 6126.0 6138.1 6152.4 6156.8 6141.7 6163.2 6169.5 6195.7 6224.9 4268.6 4289.4 4924.8 4940.1 4966.4 4435.5 4445.2 4449.0 4478.9 4490.7 5602.9 5664.6 5680.6 5830.4 5846.2 6152.5 6261.4 6283.8 6326.9 6344.5 5780.6 5790.7 5801.6 5845.9 5862.9 4813.3 5290.7 5410.1 5433.8 5446.3 5368.8 6197.8 6224.6 6243.3 6244.8 6277.0 6293.9 6300.5 6300.7 6315.7 6090.9 6242.6 6280.0 6303.1 6307.3 6047.6 6088.0 6129.3 6130.7 6255.8 6255.9 6299.6 6301.9 6306.8 6312.7 6157.4 6161.9 6170.3 6170.3 6184.8 5859.3 5887.0 5907.5 6086.1 6182.0 5944.7 6046.0 6058.3 6071.4 6105.4 6184.1 6192.9 6194.0 6195.2 6200.2 5797.0 5820.8 5921.0 6059.6 6092.9 02:25:17 INFO - PROCESS | 1648 | 02:25:17 INFO - PROCESS | 1648 | [#1] ext.html Cycles:180 Average:68874.73 Median:40239.00 stddev:151487.94 (376.5%) stddev-sans-first:151825.91 02:25:17 INFO - PROCESS | 1648 | Values: 494.5 497.2 522.5 527.6 546.7 30288.4 30739.5 39510.2 40879.6 40895.4 42289.4 42696.6 42722.6 42782.0 42925.9 9187.8 9324.8 9350.4 9353.2 9362.5 9323.8 9444.0 9444.3 9448.2 9453.4 9292.1 9375.6 9424.3 9453.7 9491.6 9395.2 9452.3 9462.8 9463.3 9479.2 9289.8 9360.4 9370.4 9373.5 9378.6 39392.8 39587.0 39671.6 39713.2 39797.2 3187.8 3230.3 3269.2 3275.6 3782.4 28911.3 29946.3 30147.5 30582.5 30892.1 3124.0 3205.9 3220.0 3221.8 3228.0 473872.0 474778.0 476044.0 476236.6 489179.0 60377.4 60776.0 60797.8 60881.4 60922.1 34563.3 35324.8 35400.6 36374.1 64074.7 15826.2 15976.1 15984.8 15998.4 16007.6 12104.6 12205.2 12219.5 12248.4 12253.8 18928.9 19011.4 19013.5 19042.9 19070.3 7379.5 7483.3 7487.8 7573.9 7593.0 833.7 916.2 960.9 980.5 1049.2 28742.0 29399.6 29430.0 30189.5 30401.5 896.7 930.6 985.5 1015.5 1043.6 12764.2 15070.8 15399.2 15511.7 16297.8 662970.0 663639.0 664653.0 665040.0 665492.0 58568.7 59165.7 59167.7 59260.1 59291.0 1144.7 1168.2 1220.7 1285.4 1362.1 28644.1 30353.5 30503.1 30734.1 31027.7 50098.5 50800.2 50855.0 50916.5 51110.2 536762.0 541522.0 541754.0 542126.0 542806.0 23875.0 26347.9 27024.0 27348.6 27536.3 45096.5 45575.1 45732.5 46437.5 46692.8 38181.6 38868.0 39566.4 39904.0 40312.6 35993.0 40180.6 40297.4 41645.6 41790.6 37752.6 37867.4 38137.0 38736.4 38964.0 32231.4 34069.8 34191.5 34790.8 34838.0 22726.4 24089.0 25552.7 25655.9 25712.0 02:25:17 INFO - PROCESS | 1648 | 02:25:17 INFO - PROCESS | 1648 | [#2] jquery.html Cycles:180 Average:34584.19 Median:376.69 stddev:100084.70 (26569.4%) stddev-sans-first:100332.45 02:25:17 INFO - PROCESS | 1648 | Values: 349.2 366.9 374.2 379.2 402.3 14832.8 15109.1 15888.6 20198.0 20606.7 18934.9 19353.0 20020.7 20200.5 20448.1 5766.9 6016.7 6016.8 6017.5 6022.9 5139.4 6522.4 6610.8 6652.1 6691.4 5077.6 5701.9 6589.5 6601.8 6652.4 6017.3 6036.8 6037.7 6043.6 6044.2 5674.7 5840.6 5892.4 5951.3 5955.9 13005.0 13117.6 13446.5 21214.0 24983.6 2526.8 2576.8 2637.7 2807.1 2909.3 10051.4 10174.9 10386.0 11642.6 15551.6 1611.0 1853.6 1856.1 1860.4 1866.9 124376.0 129027.0 130675.0 131251.3 135431.6 9318.0 9911.9 9915.3 10026.3 10576.4 10286.2 12461.3 12463.1 12464.8 12470.0 7798.3 7999.8 8036.6 8093.9 8153.7 8344.5 8347.3 8469.0 8533.0 8534.6 3826.1 3851.3 3916.3 3944.5 4003.6 1673.8 1886.8 1910.4 1922.8 1943.0 801.3 806.4 833.7 855.4 916.7 19784.5 20863.0 21016.9 21060.7 21104.6 813.9 902.5 905.7 925.9 982.6 9485.3 10476.4 10845.1 10914.6 10992.1 590564.0 596305.0 603404.0 603535.0 604856.0 94549.0 105132.0 105450.0 111566.9 134221.3 844.2 889.4 946.3 950.1 955.6 18767.5 19288.0 19565.9 19592.4 19704.8 54919.9 56507.7 57395.0 57668.4 58649.5 73591.0 76414.0 77788.0 78413.0 81133.0 7908.2 8024.7 8062.8 8170.3 8244.5 10331.6 12317.8 12483.9 12904.5 13014.2 8947.4 10881.1 11068.8 11086.3 11341.9 10667.4 10940.7 10965.9 11009.4 11016.7 11153.3 11259.5 11265.7 11315.9 11443.3 7906.8 7932.8 8073.1 8106.7 8143.9 8871.7 10899.8 11075.8 11207.0 11294.9 02:25:17 INFO - PROCESS | 1648 | 02:25:17 INFO - PROCESS | 1648 | [#3] mootools.html Cycles:180 Average:5434.71 Median:5099.36 stddev:2990.15 (58.6%) stddev-sans-first:2981.23 02:25:17 INFO - PROCESS | 1648 | Values: 1154.3 1361.9 1463.0 1543.2 1695.8 7428.7 7810.0 8159.7 8483.2 8501.7 8329.3 8408.5 8432.2 8440.1 8440.2 2320.9 2347.1 2350.0 2350.2 2353.8 2341.5 2377.3 2387.0 2387.6 2389.2 2324.0 2338.3 2358.7 2362.2 2367.3 1960.3 2283.9 2288.3 2333.6 2337.7 2338.8 2359.5 2360.9 2365.1 2365.7 8331.1 8406.1 8422.2 8442.8 8447.8 4990.7 5017.4 5191.5 5191.9 5201.2 3250.1 3331.7 3367.8 3438.2 3449.6 1005.4 1036.7 1046.5 1063.4 1082.1 10796.0 10840.3 10944.5 10952.5 10959.0 4277.1 4395.7 4493.6 4493.9 4524.6 8724.2 8730.6 8737.2 8743.2 8744.8 5099.0 5099.7 5108.0 5119.2 5120.3 3765.7 4222.6 4380.4 4646.7 4774.2 3652.5 3704.8 3711.4 3762.2 3763.2 1139.8 1142.0 1144.6 1149.9 1152.4 786.0 804.2 884.8 888.1 925.3 5558.0 5658.1 5839.9 5900.8 5949.8 810.7 869.4 918.5 922.7 931.4 3756.5 3807.2 3841.1 3924.0 3961.1 8719.5 9885.4 10158.8 10273.3 10284.7 10226.9 10230.0 10247.8 10248.0 10250.7 7805.6 7979.4 7990.3 7992.0 7995.2 5383.8 5553.0 5598.0 5775.1 5799.5 9518.9 9545.5 9546.3 9549.3 9566.2 8734.4 9204.7 9537.3 9562.1 9777.2 6279.2 6369.3 6841.6 6871.8 6942.2 8027.3 8039.6 8067.4 8144.4 8145.9 7230.0 7273.5 7282.5 7289.7 7326.4 6773.4 6931.5 7030.9 7106.6 7186.7 6723.5 6752.5 6839.3 6842.3 6843.3 4789.8 4794.5 4940.8 4959.5 5093.1 4927.0 4942.7 5008.9 5012.0 5012.6 02:25:17 INFO - PROCESS | 1648 | 02:25:17 INFO - PROCESS | 1648 | [#4] prototype.html Cycles:180 Average:4276.09 Median:4737.34 stddev:1267.72 (26.8%) stddev-sans-first:1235.62 02:25:17 INFO - PROCESS | 1648 | Values: 298.4 300.0 307.7 313.2 314.8 4745.7 4872.3 5023.8 5151.3 5262.4 4857.2 4963.4 5070.4 5071.7 5201.6 3580.5 3966.3 3966.5 3994.5 3996.4 3738.7 3942.2 3985.8 3994.8 4001.0 3406.4 3741.5 3969.8 3970.1 3988.1 3778.1 3854.6 3927.3 3947.8 3949.9 3167.9 3461.4 3468.7 3477.4 3480.9 4962.7 5012.1 5030.5 5032.9 5060.7 3615.5 4247.6 4525.4 4530.3 4542.7 4536.4 4588.8 5231.6 5412.8 5432.2 3434.9 3658.6 3827.6 3848.2 3857.7 4762.6 5603.5 5615.8 5710.3 5782.6 3417.5 3418.4 3878.7 3889.7 3890.6 3904.3 3915.2 3938.9 3951.8 3968.5 4372.7 4439.3 4509.8 4534.2 4554.8 4729.0 5387.7 5410.5 5419.8 5476.7 1258.6 1273.6 1276.6 1291.9 1295.6 734.5 819.2 839.6 867.9 893.7 4311.7 4422.8 4518.8 4613.4 4635.9 5306.2 5326.8 5332.6 5340.0 5371.6 4431.8 4508.8 4557.2 4593.0 4859.7 2349.8 2543.9 2651.5 2715.6 2732.2 4820.6 5108.4 5332.4 5484.8 5519.3 4290.4 4827.5 5308.8 5379.6 5452.4 4490.9 4903.7 4972.1 5441.3 5496.9 4882.6 5264.7 5295.8 5306.6 5314.8 4312.7 4781.8 4901.6 5125.8 5255.2 4938.0 5018.8 5325.3 5366.3 5419.9 3684.3 3701.6 3702.8 3703.6 3712.8 4490.6 4926.4 5085.6 5173.1 5324.3 4402.5 4491.6 4910.0 5141.4 5152.9 4322.8 5149.5 5156.0 5169.0 5178.3 4619.3 4666.6 4966.7 4992.8 5069.7 4898.3 4983.1 5213.1 5292.4 5504.4 5053.5 5349.4 5363.4 5365.7 5381.8 02:25:17 INFO - PROCESS | 1648 | 02:25:17 INFO - PROCESS | 1648 | [#5] yui.html Cycles:180 Average:20593.55 Median:587.62 stddev:31696.64 (5394.1%) stddev-sans-first:31750.27 02:25:17 INFO - PROCESS | 1648 | Values: 675.3 702.8 739.8 741.3 775.5 13248.2 13943.7 13944.2 13946.3 13969.9 12602.7 12606.9 12637.0 12678.8 12689.6 659.9 677.7 804.9 814.7 836.9 802.4 820.1 822.0 824.9 833.8 877.1 880.0 881.2 883.6 886.6 683.9 710.0 874.6 876.8 877.8 630.8 648.5 649.8 650.7 651.7 13196.3 13196.9 13224.3 13232.9 13253.5 12108.9 12235.1 12337.8 12372.3 12600.0 11345.8 11511.9 11605.4 11703.8 11799.5 4168.5 4218.2 4301.0 4301.7 4303.2 82848.6 85573.6 85680.6 85695.6 86630.0 9411.9 9635.0 9823.5 9980.5 10244.9 18424.8 18480.2 18535.5 18551.0 18792.8 7175.6 7267.8 7281.1 7291.0 7440.2 4028.4 4053.3 4102.9 4144.7 4299.2 3126.8 3174.8 3220.6 3221.0 3222.8 574.5 584.5 592.0 592.9 630.5 580.5 587.6 590.2 593.8 608.9 7578.2 8015.2 8576.8 8636.7 8644.9 560.6 568.5 576.9 586.6 587.7 4174.6 4180.6 4196.2 4232.1 4278.3 98824.0 109154.5 112390.4 115501.0 119747.4 77189.2 96546.0 107831.0 110828.4 111349.9 88758.0 89727.0 91214.0 91960.2 92482.0 8085.8 8118.4 8144.1 8223.5 8317.4 49081.8 57732.1 59683.0 60630.4 61704.7 83512.6 83651.6 86519.6 87461.6 88253.6 10032.0 10075.7 10250.8 10360.0 10752.4 11071.0 11558.7 11822.1 11978.8 12158.7 10877.0 10907.2 10992.3 11019.9 11349.9 10891.3 10956.9 11000.6 11144.6 11474.7 8785.0 9387.4 10392.8 10584.8 11135.0 8428.4 8579.1 8666.2 9028.0 9145.5 8812.8 8821.1 8828.7 8879.4 8899.0 02:25:17 INFO - PROCESS | 1648 | -------- Summary: end -------- 02:25:17 INFO - PROCESS | 1648 | 02:25:17 INFO - TEST-INFO | 1648: exit 0 02:25:17 INFO - TEST-OK | dromaeo_css | took 1119307ms 02:25:17 INFO - TEST-START | kraken 02:25:17 INFO - operating with platform_type : mac_ 02:25:17 INFO - Initialising browser for kraken test... 02:25:17 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmp4SrNjx/profile http://localhost:49240/getInfo.html) 02:25:20 INFO - PROCESS | 1653 | __metrics Screen width/height:1600/1200 02:25:20 INFO - PROCESS | 1653 | colorDepth:24 02:25:20 INFO - PROCESS | 1653 | Browser inner width/height: 1024/689 02:25:20 INFO - PROCESS | 1653 | __metrics 02:25:20 INFO - PROCESS | 1653 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:25:20 INFO - PROCESS | 1653 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:25:21 INFO - TEST-INFO | 1653: exit 0 02:25:21 INFO - Browser initialized. 02:25:21 INFO - Running cycle 1/1 for kraken test... 02:25:21 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmp4SrNjx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:25:33 INFO - PROCESS | 1656 | RSS: Main: 222384128 02:25:33 INFO - PROCESS | 1656 | 02:25:36 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 02:25:37 INFO - PROCESS | 1656 | RSS: Main: 270446592 02:25:37 INFO - PROCESS | 1656 | 02:25:40 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 02:25:40 INFO - PROCESS | 1656 | RSS: Main: 284909568 02:25:40 INFO - PROCESS | 1656 | 02:25:43 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 02:25:44 INFO - PROCESS | 1656 | RSS: Main: 382308352 02:25:44 INFO - PROCESS | 1656 | 02:25:46 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 02:25:47 INFO - PROCESS | 1656 | RSS: Main: 285868032 02:25:47 INFO - PROCESS | 1656 | 02:25:49 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:25:49 INFO - PROCESS | 1656 | RSS: Main: 286908416 02:25:49 INFO - PROCESS | 1656 | 02:25:52 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 02:25:53 INFO - PROCESS | 1656 | RSS: Main: 325304320 02:25:53 INFO - PROCESS | 1656 | 02:25:56 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 02:25:56 INFO - PROCESS | 1656 | RSS: Main: 328859648 02:25:56 INFO - PROCESS | 1656 | 02:25:59 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 02:26:00 INFO - PROCESS | 1656 | RSS: Main: 324370432 02:26:00 INFO - PROCESS | 1656 | 02:26:01 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:26:02 INFO - PROCESS | 1656 | RSS: Main: 299302912 02:26:02 INFO - PROCESS | 1656 | 02:26:04 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:26:04 INFO - PROCESS | 1656 | RSS: Main: 301527040 02:26:04 INFO - PROCESS | 1656 | 02:26:07 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:26:07 INFO - PROCESS | 1656 | RSS: Main: 303620096 02:26:07 INFO - PROCESS | 1656 | 02:26:10 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:26:11 INFO - PROCESS | 1656 | RSS: Main: 321417216 02:26:11 INFO - PROCESS | 1656 | 02:26:14 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:26:15 INFO - PROCESS | 1656 | RSS: Main: 315400192 02:26:15 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 02:26:16 INFO - PROCESS | 1656 | RSS: Main: 359211008 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | __start_tp_report 02:26:16 INFO - PROCESS | 1656 | _x_x_mozilla_page_load 02:26:16 INFO - PROCESS | 1656 | _x_x_mozilla_page_load_details 02:26:16 INFO - PROCESS | 1656 | |i|pagename|runs| 02:26:16 INFO - PROCESS | 1656 | |0;ai-astar;104;114;114;113;115;114;114;113;115;115 02:26:16 INFO - PROCESS | 1656 | |1;audio-beat-detection;143;110;104;145;109;132;140;93;162;142 02:26:16 INFO - PROCESS | 1656 | |2;audio-dft;179;183;187;186;183;180;185;185;181;184 02:26:16 INFO - PROCESS | 1656 | |3;audio-fft;81;59;59;89;61;60;59;63;107;81 02:26:16 INFO - PROCESS | 1656 | |4;audio-oscillator;93;93;123;99;68;69;91;67;69;93 02:26:16 INFO - PROCESS | 1656 | |5;imaging-gaussian-blur;89;84;88;85;88;85;88;85;87;84 02:26:16 INFO - PROCESS | 1656 | |6;imaging-darkroom;96;97;95;112;159;118;94;96;112;158 02:26:16 INFO - PROCESS | 1656 | |7;imaging-desaturate;84;85;79;78;78;81;83;83;81;83 02:26:16 INFO - PROCESS | 1656 | |8;json-parse-financial;55;54;54;54;57;58;58;57;56;57 02:26:16 INFO - PROCESS | 1656 | |9;json-stringify-tinderbox;73;68;70;74;72;71;70;72;72;72 02:26:16 INFO - PROCESS | 1656 | |10;stanford-crypto-aes;81;87;84;82;83;82;81;82;82;85 02:26:16 INFO - PROCESS | 1656 | |11;stanford-crypto-ccm;154;157;150;152;151;158;143;143;171;149 02:26:16 INFO - PROCESS | 1656 | |12;stanford-crypto-pbkdf2;165;168;181;151;207;220;169;168;166;164 02:26:16 INFO - PROCESS | 1656 | |13;stanford-crypto-sha256-iterative;68;67;68;66;65;67;65;67;66;67 02:26:16 INFO - PROCESS | 1656 | __end_tp_report 02:26:16 INFO - PROCESS | 1656 | __start_cc_report 02:26:16 INFO - PROCESS | 1656 | _x_x_mozilla_cycle_collect,1962 02:26:16 INFO - PROCESS | 1656 | __end_cc_report 02:26:16 INFO - PROCESS | 1656 | __startTimestamp1485167176976__endTimestamp 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | ------- Summary: start ------- 02:26:16 INFO - PROCESS | 1656 | Number of tests: 14 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.28 (2.9%) stddev-sans-first:0.78 02:26:16 INFO - PROCESS | 1656 | Values: 104.0 114.0 114.0 113.0 115.0 114.0 114.0 113.0 115.0 115.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#1] audio-beat-detection Cycles:10 Average:128.00 Median:142.50 stddev:22.39 (15.7%) stddev-sans-first:23.08 02:26:16 INFO - PROCESS | 1656 | Values: 143.0 110.0 104.0 145.0 109.0 132.0 140.0 93.0 162.0 142.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.50 stddev:2.63 (1.4%) stddev-sans-first:2.28 02:26:16 INFO - PROCESS | 1656 | Values: 179.0 183.0 187.0 186.0 183.0 180.0 185.0 185.0 181.0 184.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#3] audio-fft Cycles:10 Average:71.90 Median:62.00 stddev:16.76 (27.0%) stddev-sans-first:17.45 02:26:16 INFO - PROCESS | 1656 | Values: 81.0 59.0 59.0 89.0 61.0 60.0 59.0 63.0 107.0 81.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:92.00 stddev:18.17 (19.7%) stddev-sans-first:19.12 02:26:16 INFO - PROCESS | 1656 | Values: 93.0 93.0 123.0 99.0 68.0 69.0 91.0 67.0 69.0 93.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:87.50 stddev:1.89 (2.2%) stddev-sans-first:1.73 02:26:16 INFO - PROCESS | 1656 | Values: 89.0 84.0 88.0 85.0 88.0 85.0 88.0 85.0 87.0 84.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#6] imaging-darkroom Cycles:10 Average:113.70 Median:94.50 stddev:25.13 (26.6%) stddev-sans-first:25.82 02:26:16 INFO - PROCESS | 1656 | Values: 96.0 97.0 95.0 112.0 159.0 118.0 94.0 96.0 112.0 158.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#7] imaging-desaturate Cycles:10 Average:81.50 Median:83.00 stddev:2.51 (3.0%) stddev-sans-first:2.49 02:26:16 INFO - PROCESS | 1656 | Values: 84.0 85.0 79.0 78.0 78.0 81.0 83.0 83.0 81.0 83.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#8] json-parse-financial Cycles:10 Average:56.00 Median:57.00 stddev:1.63 (2.9%) stddev-sans-first:1.69 02:26:16 INFO - PROCESS | 1656 | Values: 55.0 54.0 54.0 54.0 57.0 58.0 58.0 57.0 56.0 57.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#9] json-stringify-tinderbox Cycles:10 Average:71.40 Median:72.00 stddev:1.71 (2.4%) stddev-sans-first:1.72 02:26:16 INFO - PROCESS | 1656 | Values: 73.0 68.0 70.0 74.0 72.0 71.0 70.0 72.0 72.0 72.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.50 stddev:1.91 (2.3%) stddev-sans-first:1.90 02:26:16 INFO - PROCESS | 1656 | Values: 81.0 87.0 84.0 82.0 83.0 82.0 81.0 82.0 82.0 85.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#11] stanford-crypto-ccm Cycles:10 Average:152.80 Median:153.00 stddev:8.13 (5.3%) stddev-sans-first:8.62 02:26:16 INFO - PROCESS | 1656 | Values: 154.0 157.0 150.0 152.0 151.0 158.0 143.0 143.0 171.0 149.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:168.50 stddev:21.31 (12.6%) stddev-sans-first:22.24 02:26:16 INFO - PROCESS | 1656 | Values: 165.0 168.0 181.0 151.0 207.0 220.0 169.0 168.0 166.0 164.0 02:26:16 INFO - PROCESS | 1656 | 02:26:16 INFO - PROCESS | 1656 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.60 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.01 02:26:16 INFO - PROCESS | 1656 | Values: 68.0 67.0 68.0 66.0 65.0 67.0 65.0 67.0 66.0 67.0 02:26:16 INFO - PROCESS | 1656 | -------- Summary: end -------- 02:26:16 INFO - PROCESS | 1656 | 02:26:17 INFO - TEST-INFO | 1656: exit 0 02:26:18 INFO - TEST-OK | kraken | took 60379ms 02:26:18 INFO - SUITE-END | took 1179s 02:26:18 INFO - Completed test suite (00:19:39) 02:26:18 INFO - javascript benchmark 02:26:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3319.3195394944037, 3335.7164641005515, 3350.8492117854694, 3382.222088919547, 3420.8631654733813, 5668.376478587357, 5682.488576028157, 5738.971305143479, 5751.942480575198, 5793.507551858092, 5696.658200507973, 5783.190353350535, 5784.913226301609, 5799.391063938278, 5802.680852553108, 5251.212318152279, 5277.340332458442, 5298.761555729982, 5302.257683924235, 5322.547583455411, 5199.68801871887, 5207.583393328525, 5359.0, 5366.4633536646415, 5377.946220537784, 5187.066328060948, 5241.947580524203, 5262.60530460217, 5324.41431442541, 5333.0, 5256.159014557691, 5256.842294731164, 5271.894562108775, 5273.129933560957, 5281.260623512692, 5213.661112027706, 5281.63028587999, 5299.867503312409, 5300.337457817773, 5301.151815709468, 4804.375431193957, 5499.587530935196, 5613.101903695389, 5769.740361683735, 5867.530597552186, 6087.117367981662, 6119.756006473298, 6138.140660307516, 6147.2930612979635, 6174.44430001302, 6177.1260296868395, 6210.65841378724, 6255.0, 6289.7169627366875, 6294.433500984887, 5630.5214056805635, 5741.799037033684, 5765.250517432707, 5770.451807078321, 5799.420057994167, 6229.53278504114, 6253.593516421418, 6259.624422534663, 6279.089532017923, 6286.308506064329, 6169.413905678954, 6182.505399568024, 6184.196054512884, 6186.783462578878, 6196.225471816023, 6102.328743838174, 6291.056341548804, 6319.905201421982, 6323.30443651198, 6330.746770129143, 6103.511719062464, 6125.958587040125, 6138.13807813537, 6152.415520525543, 6156.78451254204, 6141.723622437001, 6163.229596300463, 6169.537284703665, 6195.729875375538, 6224.906626400608, 4268.59448352406, 4289.356596510486, 4924.75376231187, 4940.135476291706, 4966.428860681068, 4435.534268901783, 4445.222086134913, 4448.955510444919, 4478.932816007762, 4490.708103973297, 5602.915956260659, 5664.631798933056, 5680.573956953245, 5830.3586605473365, 5846.181534585162, 6152.538559608047, 6261.436470717657, 6283.7800676977, 6326.936730632727, 6344.524160687967, 5780.624259423124, 5790.652560846363, 5801.564882633819, 5845.853853653608, 5862.882742345129, 4813.278008298783, 5290.65610735301, 5410.053240682865, 5433.8369848904595, 5446.264754258124, 5368.812091576776, 6197.845053873689, 6224.564280500503, 6243.250809902841, 6244.812655620339, 6276.968615156895, 6293.937060629335, 6300.464460520907, 6300.684965751602, 6315.652639104894, 6090.908636370546, 6242.625442473466, 6279.96860015697, 6303.117563541016, 6307.274663413767, 6047.637141771508, 6087.969560152171, 6129.264488261437, 6130.7038937848565, 6255.78104766331, 6255.9374406257175, 6299.559030867796, 6301.905471418024, 6306.779262725782, 6312.747490100344, 6157.415045570664, 6161.907571386343, 6170.259568851587, 6170.321264660974, 6184.81445556634, 5859.296884373903, 5887.0, 5907.4683278505145, 6086.087086936995, 6182.010878259637, 5944.732487038007, 6046.032634778414, 6058.303295121117, 6071.423214794588, 6105.389461053859, 6184.103305020837, 6192.947198976275, 6194.0, 6195.1636529068, 6200.162977997912, 5797.0, 5820.796272130455, 5921.0, 6059.606125601822, 6092.8781424372155], "value": 5701.268073946417, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [494.5005544400156, 497.19950879084666, 522.5375542644758, 527.564759073764, 546.6747285365211, 30288.394232115344, 30739.538906916387, 39510.209795804105, 40879.59120408795, 40895.38656920149, 42289.36565951513, 42696.57303426965, 42722.572774272245, 42782.0, 42925.92685182872, 9187.816243675123, 9324.813503729922, 9350.438973661569, 9353.15821576058, 9362.531873406337, 9323.813523729521, 9443.95278023609, 9444.291678124135, 9448.24414046878, 9453.385529940531, 9292.117248861347, 9375.578098985528, 9424.293178011641, 9453.669121580746, 9491.572879220417, 9395.201407880339, 9452.338336316461, 9462.810743785154, 9463.290253230967, 9479.241660667165, 9289.814203715956, 9360.391574547633, 9370.390924589949, 9373.53132343387, 9378.577963991636, 39392.81821545358, 39587.01032474182, 39671.60328396737, 39713.20573588541, 39797.20405591872, 3187.7609179311644, 3230.305484320859, 3269.1663625775277, 3275.557799697034, 3782.3569993101237, 28911.277218069506, 29946.25134371658, 30147.547786783216, 30582.541261881088, 30892.073237802902, 3124.0315502194394, 3205.8877939272247, 3219.983900080508, 3221.7905836120576, 3227.9677203227902, 473872.0, 474778.0, 476044.0, 476236.6188169106, 489179.0, 60377.39622603806, 60776.0, 60797.78404431887, 60881.391186088455, 60922.08616870751, 34563.30873382569, 35324.82337588296, 35400.58397664064, 36374.09064773402, 64074.6796266025, 15826.208689565476, 15976.121313327878, 15984.76022859658, 15998.360065597479, 16007.59981000461, 12104.576339828063, 12205.20666156697, 12219.450124744408, 12248.44881980313, 12253.754924901452, 18928.905355473136, 19011.429657110308, 19013.524661883563, 19042.904785475985, 19070.33253836109, 7379.520331178456, 7483.32650061497, 7487.801951687813, 7573.886391704129, 7593.0, 833.7123692326138, 916.2074805293373, 960.8798900137483, 980.4803454169302, 1049.150188347441, 28742.0, 29399.559006614916, 29430.0, 30189.547156792665, 30401.543976840367, 896.7175339767953, 930.6044930904474, 985.4924713772413, 1015.4567306490992, 1043.6190790361616, 12764.170328928776, 15070.773938390932, 15399.23003849803, 15511.689766204838, 16297.755533667005, 662970.0, 663639.0, 664653.0, 665040.0, 665492.0, 58568.70715646395, 59165.704171478865, 59167.70416147978, 59260.111098332694, 59291.0, 1144.6623246142242, 1168.2056201782868, 1220.7436438347868, 1285.4215602978697, 1362.1350442469104, 28644.14067577976, 30353.544696829125, 30503.084907452812, 30734.077977660705, 31027.68972310248, 50098.49901500938, 50800.23799642934, 50854.982900342526, 50916.49083509117, 51110.23334649909, 536762.0, 541522.0, 541754.0, 542126.0, 542806.0, 23875.0, 26347.868260658575, 27024.0, 27348.589771153052, 27536.311592210353, 45096.54903450923, 45575.088498230514, 45732.542674572825, 46437.53562464332, 46692.832679183295, 38181.61818381781, 38868.028299292746, 39566.40650390189, 39904.0, 40312.59687403088, 35993.0, 40180.598194017686, 40297.395539066354, 41645.58354416417, 41790.582094178666, 37752.62247377491, 37867.431988519646, 38137.0, 38736.41895371628, 38964.0, 32231.35537289288, 34069.829650851585, 34191.4871276936, 34790.82604586961, 34838.0, 22726.431839204153, 24089.0, 25552.744472555038, 25655.871720641277, 25712.0], "value": 19458.607118683158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.1707195410899, 366.8770961727821, 374.2160174434559, 379.16772683958703, 402.3200790663778, 14832.813374930007, 15109.09345439273, 15888.566199872685, 20197.999999999964, 20606.690899636516, 18934.90532547335, 19353.03234838256, 20020.699689504632, 20200.484963627714, 20448.07983640736, 5766.942330576693, 6016.699165041752, 6016.7665628546265, 6017.548683848707, 6022.939770602282, 5139.357580302462, 6522.4129828315445, 6610.8016759497295, 6652.101966234569, 6691.36432038958, 5077.59379249661, 5701.859628074381, 6589.472842172639, 6601.768938087168, 6652.434543063845, 6017.308009578889, 6036.788712395045, 6037.667928263943, 6043.607165534227, 6044.214252147192, 5674.744636491368, 5840.591158618899, 5892.410758924116, 5951.256092988377, 5955.940440595582, 13004.959603231813, 13117.60647180586, 13446.462141514328, 21214.0, 24983.62524562133, 2526.7852232560253, 2576.8453892766493, 2637.7494138056854, 2807.1297897651793, 2909.301767575788, 10051.396916185053, 10174.931632178663, 10386.0, 11642.59250926222, 15551.611209719735, 1610.9597260068592, 1853.5829438376256, 1856.1090676475367, 1860.4325680667391, 1866.915988780508, 124376.0, 129027.0, 130675.0, 131251.3437432816, 135431.64568354288, 9318.0, 9911.900880991241, 9915.256355773347, 10026.348287361445, 10576.365418074785, 10286.177105831515, 12461.252324860538, 12463.065270104778, 12464.81302780459, 12470.0, 7798.259165379393, 7999.840003199904, 8036.598170091472, 8093.878591821127, 8153.6738530458115, 8344.457610255435, 8347.332213423033, 8468.957655211685, 8532.957335213285, 8534.573271336409, 3826.1199924017633, 3851.287511810324, 3916.3146449371247, 3944.5069366329208, 4003.619656132663, 1673.8326167383163, 1886.7735871695484, 1910.436421255733, 1922.7692676878864, 1942.9708554371696, 801.3068695578282, 806.4072906413782, 833.7457075591882, 855.3713020929612, 916.6974898283551, 19784.50538736514, 20863.0, 21016.94915254231, 21060.684089738665, 21104.577908442054, 813.8982627171604, 902.4991129922824, 905.7282815155427, 925.9305552083486, 982.5529384130203, 9485.288603354777, 10476.371417714809, 10845.13238940883, 10914.617988370368, 10992.120630349553, 590564.0, 596305.0, 603404.0, 603535.0, 604856.0, 94549.0, 105132.0, 105450.0, 111566.88433115727, 134221.32889335492, 844.2148801614558, 889.3729920406228, 946.2855544064325, 950.135376807116, 955.6416343871049, 18767.53081172927, 19288.0, 19565.902170489055, 19592.412227633195, 19704.80295197087, 54919.901601966936, 56507.71746141243, 57395.0, 57668.423315766304, 58649.5337616563, 73591.0, 76414.0, 77788.0, 78413.0, 81133.0, 7908.248716371935, 8024.679012839654, 8062.798430039296, 8170.264676179172, 8244.505329680238, 10331.586736530455, 12317.753644926872, 12483.93758031204, 12904.548340808027, 13014.15407998477, 8947.373683842328, 10881.075108615856, 11068.833967490655, 11086.334819910831, 11341.943290283496, 10667.359958402521, 10940.726481838017, 10965.890341096487, 11009.449527523751, 11016.724581885197, 11153.330800152016, 11259.493322800658, 11265.718357040812, 11315.886841131483, 11443.313401195956, 7906.802329941797, 7932.841343172989, 8073.071596766447, 8106.716264930699, 8143.918560814316, 8871.733847984571, 10899.78200435971, 11075.778484430106, 11206.99137077667, 11294.926981936704], "value": 9308.461396843895, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1154.295879513497, 1361.8570050144733, 1462.963425914352, 1543.236098131425, 1695.762593236947, 7428.6657100430475, 7810.0, 8159.714409995651, 8483.236508714215, 8501.702440414587, 8329.292010179142, 8408.537530435824, 8432.198941100585, 8440.113788052258, 8440.240378365961, 2320.918767843126, 2347.1315613223046, 2350.0247397330086, 2350.247920665388, 2353.752855950126, 2341.5433990371885, 2377.263048454976, 2386.95226095478, 2387.6299173628117, 2389.223502361731, 2323.9883800581056, 2338.3452633262627, 2358.6697862299293, 2362.196853069956, 2367.2543148908126, 1960.3334866145508, 2283.897224624896, 2288.302067869299, 2333.556624241389, 2337.742848286687, 2338.8128949683983, 2359.457324815285, 2360.9409764755846, 2365.136725095345, 2365.716114066323, 8331.12523185069, 8406.117357677416, 8422.24199822019, 8442.831143377098, 8447.831043379098, 4990.700557966497, 5017.422996355429, 5191.480851914778, 5191.896162076775, 5201.24581935621, 3250.089974807034, 3331.6501767314326, 3367.7810942288916, 3438.209211881256, 3449.6032956209856, 1005.4369553050242, 1036.6682661548307, 1046.4976811130623, 1063.4310643805604, 1082.0586090101583, 10796.028357447789, 10840.349579025284, 10944.4527773611, 10952.452377381178, 10959.0, 4277.144571085733, 4395.7362558246605, 4493.573110554492, 4493.88765280864, 4524.5701658342405, 8724.171203735761, 8730.563471826383, 8737.169968852948, 8743.169398907094, 8744.825103497895, 5099.031184075014, 5099.69401835891, 5108.003939231814, 5119.232115182753, 5120.334356533627, 3765.6799172070682, 4222.59885310895, 4380.364847097153, 4646.697964632355, 4774.236122220428, 3652.5251717276583, 3704.7962362070343, 3711.4247291669835, 3762.172322089136, 3763.2124740748473, 1139.7549526851767, 1141.960031398897, 1144.605111236622, 1149.8735139134687, 1152.3949926288599, 785.9607019648995, 804.159653162435, 884.8318819424288, 888.0852721696663, 925.3106435705308, 5557.972210139004, 5658.066419040812, 5839.941600584025, 5900.763969441175, 5949.791757288474, 810.720301495983, 869.4133206897311, 918.4718786697542, 922.7370199493113, 931.3713243560705, 3756.549214094326, 3807.200487897517, 3841.0781412461365, 3923.9993801580986, 3961.1087505311075, 8719.476831390137, 9885.406875587487, 10158.847617285746, 10273.332233404954, 10284.691459256233, 10226.897731022744, 10230.02814732614, 10247.795044099077, 10248.0, 10250.692479225636, 7805.609719514002, 7979.3616510679, 7990.3208227300165, 7992.0, 7995.200479951958, 5383.838484845461, 5552.972235138798, 5598.0, 5775.133729940542, 5799.5070419014855, 9518.857217141887, 9545.47499887485, 9546.284028697737, 9549.283803714889, 9566.182425339164, 8734.388592798443, 9204.677836275967, 9537.284703647116, 9562.091601297865, 9777.217822574035, 6279.183706118175, 6369.299377068612, 6841.555298905754, 6871.793846184622, 6942.201646810479, 8027.2775450209765, 8039.598020099089, 8067.354611631173, 8144.429889907649, 8145.918540814516, 7230.023946767119, 7273.454490913308, 7282.45381596393, 7289.744858929912, 7326.413886889142, 6773.356531129535, 6931.514793964576, 7030.859382812213, 7106.609136497335, 7186.7125314986815, 6723.495737819585, 6752.459803215829, 6839.2818754032105, 6842.315768423118, 6843.281455447305, 4789.784459699392, 4794.472608013186, 4940.802367905244, 4959.454460009469, 5093.0577843099145, 4926.950730492649, 4942.703437793743, 5008.924866127084, 5012.022655582126, 5012.649114561946], "value": 4385.960104763234, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [298.42404159971255, 299.99100026999173, 307.6999925073054, 313.1810316023598, 314.83471177631725, 4745.715257084573, 4872.293517439969, 5023.8492845214705, 5151.304573882525, 5262.4478477028, 4857.198562237227, 4963.3547638806995, 5070.366204224472, 5071.74641267936, 5201.5955691963145, 3580.4808302796077, 3966.305896468121, 3966.504186976628, 3994.4607477990535, 3996.38146550646, 3738.738288319819, 3942.211557688474, 3985.7807820569856, 3994.8002599870038, 4000.999500249875, 3406.42090844557, 3741.494898188737, 3969.7618142911374, 3970.1067259866445, 3988.082740969579, 3778.0554861284677, 3854.5952674969003, 3927.293087244295, 3947.842086316544, 3949.861754838567, 3167.8732850685947, 3461.35585596842, 3468.739844511672, 3477.426224672926, 3480.860765569374, 4962.702237865739, 5012.122878496249, 5030.522100400456, 5032.899342013139, 5060.721660308682, 3615.493830863681, 4247.555831017469, 4525.411696479469, 4530.278494172194, 4542.727436353829, 4536.432945881765, 4588.839390621312, 5231.633785635007, 5412.833492406947, 5432.239486471897, 3434.8797792077157, 3658.6462110089174, 3827.559830619459, 3848.172642881766, 3857.729958902878, 4762.64280178988, 5603.523700485463, 5615.831525054255, 5710.314762228476, 5782.595218334718, 3417.470292104728, 3418.384690755638, 3878.650921417086, 3889.669378102893, 3890.6498415142205, 3904.29092362257, 3915.197384536163, 3938.936487148454, 3951.8419263229725, 3968.503937007874, 4372.650187984954, 4439.334099884978, 4509.842155524541, 4534.229181039165, 4554.772261386917, 4728.966544385947, 5387.676739395649, 5410.458954104558, 5419.783208671609, 5476.67139971603, 1258.5657948007922, 1273.5924504158766, 1276.6297773645724, 1291.9095663303667, 1295.5854126679371, 734.4858598980735, 819.2012787532109, 839.6221700234919, 867.9392442529089, 893.7497500699815, 4311.741295522279, 4422.823087076481, 4518.81924723014, 4613.423322084739, 4635.907281854344, 5306.230596563477, 5326.840194794085, 5332.6000549958135, 5340.0, 5371.57027437804, 4431.822727090945, 4508.774561271924, 4557.225271703818, 4593.0, 4859.7327147006545, 2349.8355115141776, 2543.8982440702534, 2651.482960822621, 2715.6198132261497, 2732.2486316263185, 4820.6020254126615, 5108.361454818148, 5332.3867755207875, 5484.7531861066345, 5519.254900588449, 4290.435633480779, 4827.472543937172, 5308.814191503279, 5379.6234263601955, 5452.427495113036, 4490.910181796411, 4903.730294833818, 4972.0801651694555, 5441.26542916717, 5496.890062198733, 4882.60939124862, 5264.657797243321, 5295.814646487509, 5306.628536002443, 5314.760835762323, 4312.719673221231, 4781.832635857728, 4901.558859702502, 5125.79332468643, 5255.159174532057, 4937.975310123426, 5018.774155162953, 5325.307709997675, 5366.329208848894, 5419.891602167856, 3684.281565094781, 3701.574318953355, 3702.7593206441493, 3703.6481534254203, 3712.8329225184393, 4490.618297444623, 4926.433460152129, 5085.64400491962, 5173.1464308388695, 5324.334458192726, 4402.493713223021, 4491.640668746558, 4909.9558273870425, 5141.38303403594, 5152.896942061213, 4322.78386080701, 5149.459306772885, 5155.9742201288755, 5168.984096202409, 5178.275041494118, 4619.260918253198, 4666.556677115668, 4966.6771659842, 4992.775325110451, 5069.721165335942, 4898.338724272177, 4983.127952608206, 5213.142274716758, 5292.380271765501, 5504.4495550444635, 5053.509214781575, 5349.438308977501, 5363.356397232357, 5365.704886231295, 5381.770937437506], "value": 3873.9120039988434, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.2707076357534, 702.8172675104473, 739.8150462384403, 741.2809574712527, 775.5308038636626, 13248.205107693546, 13943.721125577482, 13944.163350198982, 13946.302684865766, 13969.930150349246, 12602.684932876682, 12606.873931260685, 12636.989040876731, 12678.80981785274, 12689.619311420649, 659.8647277308164, 677.6882633988371, 804.8712206047034, 814.722994181978, 836.8870202522672, 802.3821657323887, 820.1388542030874, 821.9835603287961, 824.9257566818985, 833.8248967716787, 877.1316396767187, 879.9560021998907, 881.1540920716088, 883.6156272021659, 886.5522910929972, 683.9350261725178, 710.0201721624177, 874.5889431966965, 876.7676565710092, 877.846376884046, 630.8359826445111, 648.45205801098, 649.772579597142, 650.7266947881901, 651.7230177174729, 13196.274204918725, 13196.86803131966, 13224.338783060808, 13232.933835330858, 13253.536126235633, 12108.878911210862, 12235.143539952207, 12337.814932776015, 12372.257664540157, 12600.0, 11345.829812552818, 11511.942440287745, 11605.4197290136, 11703.824442633368, 11799.46902389386, 4168.478940132483, 4218.2196293685765, 4300.978495107504, 4301.720388174758, 4303.225419424502, 82848.58575707143, 85573.57213213894, 85680.57159714223, 85695.5715221426, 86630.0, 9411.90588094124, 9634.951825240969, 9823.508824558743, 9980.500974951223, 10244.948775256076, 18424.81575184258, 18480.168392422103, 18535.53661158455, 18551.0, 18792.81207187938, 7175.605341706152, 7267.818304542323, 7281.089863767029, 7290.9635451822405, 7440.181580026193, 4028.436018957348, 4053.331200351909, 4102.876913692534, 4144.730592511477, 4299.183155200564, 3126.765492588065, 3174.7618928579986, 3220.5974253218346, 3220.951685724716, 3222.8388580570877, 574.4829653312053, 584.4535359438938, 591.961522501036, 592.9288485381695, 630.4735545819292, 580.4891695308102, 587.5769445998959, 590.1737567405667, 593.7773334999375, 608.9025755879038, 7578.166401695809, 8015.238552337519, 8576.828463430697, 8636.654533818577, 8644.91355086441, 560.5727201218713, 568.5394830187562, 576.9423057694281, 586.589387428793, 587.6650309323644, 4174.603412675791, 4180.6412915801875, 4196.244675958357, 4232.068944832132, 4278.336857787048, 98824.0, 109154.45422772835, 112390.43804781088, 115501.0, 119747.40126299312, 77189.21080918954, 96546.0, 107831.0, 110828.44585777019, 111349.88650113557, 88758.0, 89727.0, 91214.0, 91960.16079678369, 92482.0, 8085.757427277191, 8118.431709780259, 8144.086139757034, 8223.465474744122, 8317.376196785144, 49081.75459122682, 57732.13401798892, 59683.0, 60630.39369606424, 61704.69147654233, 83512.58243708986, 83651.5817420909, 86519.56740216259, 87461.56269218613, 88253.55873220593, 10032.046955539212, 10075.697729068139, 10250.846237306298, 10360.015798499131, 10752.40861752611, 11071.0, 11558.653240402802, 11822.054235661299, 11978.820317695416, 12158.696032598902, 10877.021068103908, 10907.236493445384, 10992.28550144238, 11019.889801102207, 11349.886501134883, 10891.292066015683, 10956.890431095906, 11000.559977600806, 11144.60993865211, 11474.655760327203, 8785.0, 9387.389819661701, 10392.792144156923, 10584.84122738175, 11135.0, 8428.410011299151, 8579.14208579137, 8666.220040196413, 9028.0, 9145.542722863696, 8812.779680508038, 8821.073787252246, 8828.690995815115, 8879.378443508893, 8899.02110767828], "value": 6887.701850569133, "unit": "score"}], "name": "dromaeo_css", "value": 7031.528948985964, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 113.0, 115.0, 114.0, 114.0, 113.0, 115.0, 115.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 110.0, 104.0, 145.0, 109.0, 132.0, 140.0, 93.0, 162.0, 142.0], "value": 128.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 183.0, 187.0, 186.0, 183.0, 180.0, 185.0, 185.0, 181.0, 184.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 89.0, 61.0, 60.0, 59.0, 63.0, 107.0, 81.0], "value": 71.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 123.0, 99.0, 68.0, 69.0, 91.0, 67.0, 69.0, 93.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 88.0, 85.0, 88.0, 85.0, 88.0, 85.0, 87.0, 84.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 112.0, 159.0, 118.0, 94.0, 96.0, 112.0, 158.0], "value": 113.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 79.0, 78.0, 78.0, 81.0, 83.0, 83.0, 81.0, 83.0], "value": 81.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 54.0, 54.0, 57.0, 58.0, 58.0, 57.0, 56.0, 57.0], "value": 56.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 68.0, 70.0, 74.0, 72.0, 71.0, 70.0, 72.0, 72.0, 72.0], "value": 71.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 87.0, 84.0, 82.0, 83.0, 82.0, 81.0, 82.0, 82.0, 85.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 157.0, 150.0, 152.0, 151.0, 158.0, 143.0, 143.0, 171.0, 149.0], "value": 152.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 168.0, 181.0, 151.0, 207.0, 220.0, 169.0, 168.0, 166.0, 164.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 68.0, 66.0, 65.0, 67.0, 65.0, 67.0, 66.0, 67.0], "value": 66.6, "unit": "score"}], "name": "kraken", "value": 1469.8999999999999, "alertThreshold": 2.0}]} 02:26:18 INFO - Return code: 0 02:26:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:26:18 INFO - # TBPL SUCCESS # 02:26:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:26:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:26:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:26:18 INFO - 2017-01-23 02:26:18.309 screenresolution[1660:10478] starting screenresolution argv=screenresolution get 02:26:18 INFO - 2017-01-23 02:26:18.312 screenresolution[1660:10478] Display 0: 1600x1200x32@60 02:26:18 INFO - 2017-01-23 02:26:18.318 screenresolution[1661:10481] starting screenresolution argv=screenresolution list 02:26:18 INFO - Available Modes on Display 0 02:26:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:26:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:26:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:26:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:26:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:26:18 INFO - Intel Iris: 02:26:18 INFO - Chipset Model: Intel Iris 02:26:18 INFO - Type: GPU 02:26:18 INFO - Bus: Built-In 02:26:18 INFO - VRAM (Dynamic, Max): 1536 MB 02:26:18 INFO - Vendor: Intel (0x8086) 02:26:18 INFO - Device ID: 0x0a2e 02:26:18 INFO - Revision ID: 0x0009 02:26:18 INFO - Displays: 02:26:18 INFO - Display: 02:26:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:26:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:26:18 INFO - Display Serial Number: 1600x1200 60 02:26:18 INFO - Main Display: Yes 02:26:18 INFO - Mirror: Off 02:26:18 INFO - Online: Yes 02:26:18 INFO - Rotation: Supported 02:26:18 INFO - Return code: 0 02:26:18 INFO - Running post-action listener: _resource_record_post_action 02:26:18 INFO - [mozharness: 2017-01-23 10:26:18.560625Z] Finished run-tests step (success) 02:26:18 INFO - Running post-run listener: _resource_record_post_run 02:26:18 INFO - Total resource usage - Wall time: 1212s; CPU: 54.0%; Read bytes: 32607232; Write bytes: 664503296; Read time: 201; Write time: 1941 02:26:18 INFO - TinderboxPrint: CPU usage
53.6% 02:26:18 INFO - TinderboxPrint: I/O read bytes / time
32,607,232 / 201 02:26:18 INFO - TinderboxPrint: I/O write bytes / time
664,503,296 / 1,941 02:26:18 INFO - TinderboxPrint: CPU idle
2,249.9 (46.4%) 02:26:18 INFO - TinderboxPrint: CPU system
968.0 (20.0%) 02:26:18 INFO - TinderboxPrint: CPU user
1,631.7 (33.6%) 02:26:18 INFO - TinderboxPrint: Swap in / out
380,583,936 / 0 02:26:18 INFO - install - Wall time: 32s; CPU: 54.0%; Read bytes: 341410304; Write bytes: 336217600; Read time: 26852; Write time: 726 02:26:18 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 31673344; Write bytes: 310558208; Read time: 190; Write time: 1161 02:26:19 INFO - Running post-run listener: _upload_blobber_files 02:26:19 INFO - Blob upload gear active. 02:26:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:26:19 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 02:26:19 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'] 02:26:19 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 02:26:19 INFO - (blobuploader) - INFO - Open directory for files ... 02:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:26:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:20 INFO - (blobuploader) - INFO - Done attempting. 02:26:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:26:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:26:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:21 INFO - (blobuploader) - INFO - Done attempting. 02:26:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:26:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:26:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:26:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:26:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:26:23 INFO - (blobuploader) - INFO - Done attempting. 02:26:23 INFO - (blobuploader) - INFO - Iteration through files over. 02:26:23 INFO - Return code: 0 02:26:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:26:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:26:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b39aeea8b61e7c46de9d73c8584d2ce0de67c5554239039d9d8d0780b5b85de015ad143b49511580854ffd95bd24eeeb8770552879bf67b4326da14ed24c065c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ef1c83e5127b03d2b9c3d5c9880214aeeb3f523d0dfaca1955ae8f558fe47022995260493e41d6034cc820094ea7d21aa8369d41b278d287ce758803d1ef835", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bab296b9c90c603a3dc9e881bb1f165526bd021874ec0c8500d6b36b7c1041589aff9670a5c3415af937d49a6c873b2b014e563b82de5915d3d297819e62c25"} 02:26:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:26:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:26:23 INFO - Contents: 02:26:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b39aeea8b61e7c46de9d73c8584d2ce0de67c5554239039d9d8d0780b5b85de015ad143b49511580854ffd95bd24eeeb8770552879bf67b4326da14ed24c065c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ef1c83e5127b03d2b9c3d5c9880214aeeb3f523d0dfaca1955ae8f558fe47022995260493e41d6034cc820094ea7d21aa8369d41b278d287ce758803d1ef835", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bab296b9c90c603a3dc9e881bb1f165526bd021874ec0c8500d6b36b7c1041589aff9670a5c3415af937d49a6c873b2b014e563b82de5915d3d297819e62c25"} 02:26:23 INFO - Running post-run listener: copy_logs_to_upload_dir 02:26:23 INFO - Copying logs to upload dir... 02:26:23 INFO - mkdir: /builds/slave/test/build/upload/logs 02:26:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.031266 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2017-01-23 02:26:23.480128) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 02:26:23.484998) ========= 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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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/b39aeea8b61e7c46de9d73c8584d2ce0de67c5554239039d9d8d0780b5b85de015ad143b49511580854ffd95bd24eeeb8770552879bf67b4326da14ed24c065c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ef1c83e5127b03d2b9c3d5c9880214aeeb3f523d0dfaca1955ae8f558fe47022995260493e41d6034cc820094ea7d21aa8369d41b278d287ce758803d1ef835", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bab296b9c90c603a3dc9e881bb1f165526bd021874ec0c8500d6b36b7c1041589aff9670a5c3415af937d49a6c873b2b014e563b82de5915d3d297819e62c25"} build_url:https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010948 build_url: 'https://queue.taskcluster.net/v1/task/DTHTUpsZShGlECIbtHSD1Q/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b39aeea8b61e7c46de9d73c8584d2ce0de67c5554239039d9d8d0780b5b85de015ad143b49511580854ffd95bd24eeeb8770552879bf67b4326da14ed24c065c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1ef1c83e5127b03d2b9c3d5c9880214aeeb3f523d0dfaca1955ae8f558fe47022995260493e41d6034cc820094ea7d21aa8369d41b278d287ce758803d1ef835", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7bab296b9c90c603a3dc9e881bb1f165526bd021874ec0c8500d6b36b7c1041589aff9670a5c3415af937d49a6c873b2b014e563b82de5915d3d297819e62c25"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-23 02:26:23.519363) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:26:23.519700) ========= 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.2rSNmIjNpx/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.6aqN1XhNiO/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.005037 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-23 02:26:23.568518) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 02:26:23.568838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-23 02:26:23.569133) ========= ========= Total master_lag: 0.19 =========